-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Sat 2025-07-19 06:00:57 CDT. -- Jul 19 05:59:00 garage-stereo volumio[790]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Jul 19 05:59:02 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 19 05:59:04 garage-stereo volumiologrotate[468]: ls: cannot access '/var/log/samba/log.wb-GARAGE': No such file or directory Jul 19 05:59:04 garage-stereo volumiologrotate[468]: ls: cannot access 'STEREO': No such file or directory Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 19 05:59:06 garage-stereo volumio[790]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 19 05:59:06 garage-stereo volumio[790]: info: Received Get System Version Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 19 05:59:06 garage-stereo volumio[790]: info: Received Get System Info Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 19 05:59:06 garage-stereo volumio[790]: info: Discovery: Getting this device information Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:06 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 19 05:59:07 garage-stereo volumio[790]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Jul 19 05:59:07 garage-stereo volumio[790]: info: Preparing to generate the ALSA configuration file Jul 19 05:59:07 garage-stereo volumio[790]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 19 05:59:07 garage-stereo volumio[790]: info: Reading ALSA contributions from plugins. Jul 19 05:59:07 garage-stereo volumio[790]: info: Asound.conf file unchanged, so no further update is needed Jul 19 05:59:07 garage-stereo volumio[790]: info: Output device has changed, restarting MPD Jul 19 05:59:07 garage-stereo volumio[790]: info: Output device has changed, restarting Shairport Sync Jul 19 05:59:07 garage-stereo sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:07 garage-stereo sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:07 garage-stereo sudo[1066]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:07 garage-stereo sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 19 05:59:07 garage-stereo sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:07 garage-stereo systemd[1]: musicservicesshield.service: Succeeded. Jul 19 05:59:07 garage-stereo systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jul 19 05:59:07 garage-stereo systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Jul 19 05:59:07 garage-stereo volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 19 05:59:07 garage-stereo volumio[790]: info: ___________ START PLUGINS ___________ Jul 19 05:59:07 garage-stereo systemd[1]: Listening on mpd.socket. Jul 19 05:59:07 garage-stereo systemd[1]: Starting Music Player Daemon... Jul 19 05:59:07 garage-stereo volumio[790]: info: ControllerMpd::onStart: Initializing MPD Jul 19 05:59:07 garage-stereo volumio[790]: info: Creating MPD Configuration file Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 19 05:59:07 garage-stereo volumio[790]: info: [1752922747901] CoreMusicLibrary::Adding element Media Servers Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 19 05:59:07 garage-stereo sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 19 05:59:07 garage-stereo sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:07 garage-stereo sudo[1093]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:07 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:07 garage-stereo sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 19 05:59:07 garage-stereo sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:07 garage-stereo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 19 05:59:07 garage-stereo systemd[1]: mpd.service: Succeeded. Jul 19 05:59:07 garage-stereo systemd[1]: Stopped Music Player Daemon. Jul 19 05:59:08 garage-stereo volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 19 05:59:08 garage-stereo volumio[790]: info: [1752922748084] CoreMusicLibrary::Adding element Last_100 Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 19 05:59:08 garage-stereo systemd[1]: Starting Music Player Daemon... Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 19 05:59:08 garage-stereo volumio[790]: info: [1752922748092] CoreMusicLibrary::Adding element Webradio Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 19 05:59:08 garage-stereo volumio[790]: info: Creating Spotify config file Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: GPIO-Buttons: Reading config and creating triggers... Jul 19 05:59:08 garage-stereo volumio[790]: info: Volumio Calling Home Jul 19 05:59:08 garage-stereo sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start pirateaudio.service Jul 19 05:59:08 garage-stereo sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:08 garage-stereo volumio[790]: info: GPIO-Buttons started Jul 19 05:59:08 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:08 garage-stereo sudo[1139]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:08 garage-stereo sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jul 19 05:59:08 garage-stereo sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:08 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:08 garage-stereo volumio[790]: info: Pirate audio service (daemon) started Jul 19 05:59:08 garage-stereo volumio[790]: info: MPD Permissions set Jul 19 05:59:08 garage-stereo volumio[790]: info: MPD Permissions set Jul 19 05:59:08 garage-stereo volumio[790]: info: Spotify config file written Jul 19 05:59:08 garage-stereo volumio[790]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 11 Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:08 garage-stereo sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 19 05:59:08 garage-stereo sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:08 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 05:59:10 garage-stereo volumio[790]: info: No need to fix Spotify hosts Jul 19 05:59:10 garage-stereo systemd[1]: Started go-librespot Daemon. Jul 19 05:59:10 garage-stereo sudo[1155]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:10 garage-stereo go-librespot[1162]: go-librespot daemon starting... Jul 19 05:59:10 garage-stereo volumio[790]: info: Volumio called home Jul 19 05:59:10 garage-stereo volumio[790]: info: Starting Shairport Sync Jul 19 05:59:10 garage-stereo volumio[790]: info: Starting Shairport Sync Jul 19 05:59:10 garage-stereo volumio[790]: info: Starting Shairport Sync Jul 19 05:59:10 garage-stereo sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 19 05:59:10 garage-stereo sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:10 garage-stereo sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 19 05:59:10 garage-stereo sudo[1170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 19 05:59:10 garage-stereo sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:10 garage-stereo sudo[1170]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 19 05:59:10 garage-stereo volumio[790]: info: Discovery: Getting this device information Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:10 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 19 05:59:10 garage-stereo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 19 05:59:10 garage-stereo systemd[1]: shairport-sync.service: Succeeded. Jul 19 05:59:10 garage-stereo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 19 05:59:10 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:10 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:10 garage-stereo volumio[790]: info: [ASDebug] CurState: stop PrevState: na Jul 19 05:59:10 garage-stereo volumio[790]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 19 05:59:10 garage-stereo volumio[790]: info: [ASDebug] CurState: stop PrevState: na Jul 19 05:59:10 garage-stereo volumio[790]: info: [ASDebug] InitTimeout - Amp off in: 720 ms Jul 19 05:59:10 garage-stereo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 19 05:59:10 garage-stereo sudo[1172]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:10 garage-stereo sudo[1168]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:10 garage-stereo sudo[1170]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:10 garage-stereo volumio[790]: info: Shairport-Sync Started Jul 19 05:59:10 garage-stereo volumio[790]: Error adding Membership: Error: addMembership EINVAL Jul 19 05:59:10 garage-stereo volumio[790]: info: Shairport-Sync Started Jul 19 05:59:10 garage-stereo volumio[790]: info: Shairport-Sync Started Jul 19 05:59:11 garage-stereo volumio[790]: info: [ASDebug] Togle GPIO: OFF Jul 19 05:59:11 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:11-05:00" level=info msg="running go-librespot 0.2.0" Jul 19 05:59:11 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:11-05:00" level=debug msg="app state loaded" Jul 19 05:59:11 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:11-05:00" level=debug msg="stored credentials not found" Jul 19 05:59:11 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:11-05:00" level=info msg="api server listening on 127.0.0.1:9879" Jul 19 05:59:11 garage-stereo ntpd[622]: Soliciting pool server 193.29.63.226 Jul 19 05:59:12 garage-stereo ntpd[622]: Soliciting pool server 144.202.41.38 Jul 19 05:59:12 garage-stereo ntpd[622]: Soliciting pool server 198.199.14.69 Jul 19 05:59:13 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:13-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Jul 19 05:59:13 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:13-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jul 19 05:59:13 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:13-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jul 19 05:59:13 garage-stereo volumio[790]: info: go-librespot daemon successfully initialized Jul 19 05:59:13 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:13-05:00" level=info msg="zeroconf server listening on port 33635" Jul 19 05:59:13 garage-stereo sudo[1137]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:13 garage-stereo volumio[790]: info: CoreCommandRouter::Close All Modals sent Jul 19 05:59:13 garage-stereo sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Jul 19 05:59:13 garage-stereo sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:13 garage-stereo volumio[1143]: Traceback (most recent call last): Jul 19 05:59:13 garage-stereo volumio[1143]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:13 garage-stereo volumio[1143]: import socketio Jul 19 05:59:13 garage-stereo volumio[1143]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:13 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:13 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:13 garage-stereo ntpd[622]: Soliciting pool server 144.202.62.209 Jul 19 05:59:13 garage-stereo ntpd[622]: Soliciting pool server 23.155.72.147 Jul 19 05:59:13 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:13 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 1. Jul 19 05:59:13 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:14 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:14 garage-stereo ntpd[622]: Soliciting pool server 108.61.73.243 Jul 19 05:59:14 garage-stereo ntpd[622]: Soliciting pool server 104.131.155.175 Jul 19 05:59:14 garage-stereo mpd[1101]: Jul 19 05:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 19 05:59:15 garage-stereo volumio[1197]: Traceback (most recent call last): Jul 19 05:59:15 garage-stereo volumio[1197]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:15 garage-stereo volumio[1197]: import socketio Jul 19 05:59:15 garage-stereo volumio[1197]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:15 garage-stereo systemd[1]: Started Music Player Daemon. Jul 19 05:59:15 garage-stereo sudo[1095]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:15 garage-stereo sudo[1068]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:15 garage-stereo volumio[790]: info: Completed starting Core Plugins Jul 19 05:59:15 garage-stereo volumio[790]: info: ------------------------------------------- Jul 19 05:59:15 garage-stereo volumio[790]: info: ----- MyVolumio plugins startup ---- Jul 19 05:59:15 garage-stereo volumio[790]: info: ------------------------------------------- Jul 19 05:59:15 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 19 05:59:15 garage-stereo systemd[1]: Starting Shield Volumio Music Services in the User CPU Set... Jul 19 05:59:15 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:15 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:15 garage-stereo volumio[790]: error: MPD error: The expression evaluated to a falsy value: Jul 19 05:59:15 garage-stereo volumio[790]: assert.ok(self.idling) Jul 19 05:59:15 garage-stereo volumio[790]: error: The expression evaluated to a falsy value: Jul 19 05:59:15 garage-stereo volumio[790]: assert.ok(self.idling) Jul 19 05:59:15 garage-stereo volumio[790]: error: updateQueue error: null Jul 19 05:59:15 garage-stereo volumio[790]: info: MPD running with PID1101 Jul 19 05:59:15 garage-stereo volumio[790]: ,establishing connection Jul 19 05:59:15 garage-stereo volumio[790]: error: updateQueue error: null Jul 19 05:59:15 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:15 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 2. Jul 19 05:59:15 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:15 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:15 garage-stereo volumio[1200]: cset: --> shielding system active with Jul 19 05:59:15 garage-stereo volumio[1200]: cset: "system" cpuset of CPUSPEC(1-3) with 113 tasks running Jul 19 05:59:15 garage-stereo volumio[1200]: cset: "user" cpuset of CPUSPEC(0) with 3 tasks running Jul 19 05:59:15 garage-stereo systemd[1]: Started Shield Volumio Music Services in the User CPU Set. Jul 19 05:59:15 garage-stereo systemd[1]: Reloading. Jul 19 05:59:15 garage-stereo ntpd[622]: Soliciting pool server 108.61.215.221 Jul 19 05:59:15 garage-stereo ntpd[622]: Soliciting pool server 23.186.168.128 Jul 19 05:59:16 garage-stereo ntpd[622]: Soliciting pool server 172.234.37.140 Jul 19 05:59:16 garage-stereo volumio[790]: info: Initializing connection to go-librespot Websocket Jul 19 05:59:16 garage-stereo go-librespot[1162]: time="2025-07-19T05:59:16-05:00" level=debug msg="new websocket client" Jul 19 05:59:16 garage-stereo volumio[790]: info: Connection to go-librespot Websocket established Jul 19 05:59:16 garage-stereo 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. Jul 19 05:59:16 garage-stereo volumio[1214]: Traceback (most recent call last): Jul 19 05:59:16 garage-stereo volumio[1214]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:16 garage-stereo volumio[1214]: import socketio Jul 19 05:59:16 garage-stereo volumio[1214]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:16 garage-stereo systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Jul 19 05:59:16 garage-stereo ntpd[622]: Soliciting pool server 104.233.211.205 Jul 19 05:59:16 garage-stereo ntpd[622]: Soliciting pool server 23.186.168.123 Jul 19 05:59:16 garage-stereo ntpd[622]: Soliciting pool server 192.48.105.15 Jul 19 05:59:17 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:17 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:17 garage-stereo sudo[1193]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:17 garage-stereo volumio[790]: info: succeeded Jul 19 05:59:17 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:17 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 3. Jul 19 05:59:17 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:17 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:17 garage-stereo ntpd[622]: Soliciting pool server 66.205.249.28 Jul 19 05:59:17 garage-stereo ntpd[622]: Soliciting pool server 216.82.35.115 Jul 19 05:59:17 garage-stereo ntpd[622]: Soliciting pool server 15.204.246.57 Jul 19 05:59:17 garage-stereo volumio[1232]: Traceback (most recent call last): Jul 19 05:59:17 garage-stereo volumio[1232]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:17 garage-stereo volumio[1232]: import socketio Jul 19 05:59:17 garage-stereo volumio[1232]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:18 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:18 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:18 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:18 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 4. Jul 19 05:59:18 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:18 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:18 garage-stereo ntpd[622]: Soliciting pool server 162.159.200.1 Jul 19 05:59:18 garage-stereo ntpd[622]: Soliciting pool server 74.208.25.46 Jul 19 05:59:18 garage-stereo ntpd[622]: Soliciting pool server 162.159.200.123 Jul 19 05:59:19 garage-stereo volumio[1233]: Traceback (most recent call last): Jul 19 05:59:19 garage-stereo volumio[1233]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:19 garage-stereo volumio[1233]: import socketio Jul 19 05:59:19 garage-stereo volumio[1233]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:19 garage-stereo volumio[997]: Generating RSA private key, 4096 bit long modulus (2 primes) Jul 19 05:59:19 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:19 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:19 garage-stereo volumio[790]: info: Getting Spotify volume Jul 19 05:59:19 garage-stereo volumio[790]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 12 Jul 19 05:59:19 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:19 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:19 garage-stereo volumio[790]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 19 05:59:19 garage-stereo volumio[790]: SPOTIFY: SPOTIFY VOLUME undefined Jul 19 05:59:19 garage-stereo volumio[790]: SPOTIFY: VOLUMIO VOLUME 100 Jul 19 05:59:19 garage-stereo volumio[790]: info: Aligning Spotify Volume to Volumio Volume Jul 19 05:59:19 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:19 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:19 garage-stereo volumio[790]: info: Setting Spotify Volume from Volumio: 100 Jul 19 05:59:19 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:19 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 5. Jul 19 05:59:19 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:19 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:20 garage-stereo volumio[790]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 19 05:59:20 garage-stereo volumio[1249]: Traceback (most recent call last): Jul 19 05:59:20 garage-stereo volumio[1249]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:20 garage-stereo volumio[1249]: import socketio Jul 19 05:59:20 garage-stereo volumio[1249]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:20 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:20 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:39 garage-stereo ntpd[622]: receive: Unexpected origin timestamp 0xec25f907.e1d68736 does not match aorg 0000000000.00000000 from server@198.199.14.69 xmt 0xec25f91b.3b43e398 Jul 19 05:59:39 garage-stereo ntpd[622]: receive: Unexpected origin timestamp 0xec25f907.e1d37835 does not match aorg 0000000000.00000000 from server@104.131.155.175 xmt 0xec25f91b.3b08460a Jul 19 05:59:39 garage-stereo ntpd[622]: receive: Unexpected origin timestamp 0xec25f907.e1c8c3e7 does not match aorg 0000000000.00000000 from server@23.186.168.123 xmt 0xec25f91b.3bdd29ba Jul 19 05:59:39 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:39 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 6. Jul 19 05:59:39 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:39 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:39 garage-stereo volumio[790]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jul 19 05:59:39 garage-stereo volumio[790]: info: Sending Spotify command with payload to local API: /player/volume Jul 19 05:59:40 garage-stereo volumio[790]: error: Failed to send command to Spotify local API: /player/volume: Error: Bad Request Jul 19 05:59:40 garage-stereo volumio[1250]: Traceback (most recent call last): Jul 19 05:59:40 garage-stereo volumio[1250]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:40 garage-stereo volumio[1250]: import socketio Jul 19 05:59:40 garage-stereo volumio[1250]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:40 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:40 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:40 garage-stereo volumio[997]: .............++++ Jul 19 05:59:40 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:40 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 7. Jul 19 05:59:40 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:40 garage-stereo systemd[1]: Started Service for using pirate audio display in volumio. Jul 19 05:59:41 garage-stereo volumio[1251]: Traceback (most recent call last): Jul 19 05:59:41 garage-stereo volumio[1251]: File "/data/plugins/system_hardware/pirateaudio/display.py", line 14, in Jul 19 05:59:41 garage-stereo volumio[1251]: import socketio Jul 19 05:59:41 garage-stereo volumio[1251]: ModuleNotFoundError: No module named 'socketio' Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Main process exited, code=exited, status=1/FAILURE Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Service RestartSec=100ms expired, scheduling restart. Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Scheduled restart job, restart counter is at 8. Jul 19 05:59:41 garage-stereo systemd[1]: Stopped Service for using pirate audio display in volumio. Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Start request repeated too quickly. Jul 19 05:59:41 garage-stereo systemd[1]: pirateaudio.service: Failed with result 'exit-code'. Jul 19 05:59:41 garage-stereo systemd[1]: Failed to start Service for using pirate audio display in volumio. Jul 19 05:59:41 garage-stereo volumio[790]: info: Starting Uninstall of plugin system_hardware - music_services_shield Jul 19 05:59:41 garage-stereo volumio[790]: info: Uninstalling plugin music_services_shield Jul 19 05:59:42 garage-stereo volumio[790]: info: Disabling plugin music_services_shield Jul 19 05:59:42 garage-stereo volumio[790]: info: Checking if uninstall.sh is present Jul 19 05:59:42 garage-stereo volumio[790]: info: Executing uninstall.sh Jul 19 05:59:42 garage-stereo sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Jul 19 05:59:42 garage-stereo sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:42 garage-stereo sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/removeservice.sh Jul 19 05:59:42 garage-stereo sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/music_services_shield/uninstall.sh Jul 19 05:59:42 garage-stereo sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:42 garage-stereo sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:42 garage-stereo systemd[1]: musicservicesshield.service: Succeeded. Jul 19 05:59:42 garage-stereo systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Jul 19 05:59:42 garage-stereo sudo[1283]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/removeservice.sh Jul 19 05:59:42 garage-stereo sudo[1283]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:42 garage-stereo systemd[1]: Reloading. Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin bluetooth to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin multiroom to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin metavolumio to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin cd_controller to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin smart_inputs to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: Adding plugin tidalconnect to MyMusic Plugins Jul 19 05:59:42 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jul 19 05:59:43 garage-stereo 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. Jul 19 05:59:43 garage-stereo sudo[1311]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/cset shield -r Jul 19 05:59:43 garage-stereo sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:43 garage-stereo sudo[1311]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:43 garage-stereo sudo[1270]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:43 garage-stereo systemd[1]: Reloading. Jul 19 05:59:44 garage-stereo 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. Jul 19 05:59:44 garage-stereo systemd[1]: Reloading. Jul 19 05:59:45 garage-stereo 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. Jul 19 05:59:45 garage-stereo volumio[790]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jul 19 05:59:45 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jul 19 05:59:45 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:45 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:45 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:45 garage-stereo volumio[790]: info: Starting MyVolumio Remote Streaming Endpoints Jul 19 05:59:45 garage-stereo volumio[790]: info: MyVolumio login type: Token Jul 19 05:59:45 garage-stereo volumio[790]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jul 19 05:59:45 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jul 19 05:59:46 garage-stereo sudo[1273]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:46 garage-stereo sudo[1283]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:46 garage-stereo sudo[1347]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get remove -y cpuset Jul 19 05:59:46 garage-stereo sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:47 garage-stereo volumio[790]: info: Starting Streaming Service Transparent Proxy Jul 19 05:59:48 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jul 19 05:59:48 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jul 19 05:59:48 garage-stereo volumio[790]: info: Streaming services startup Jul 19 05:59:48 garage-stereo volumio[790]: info: Starting Streaming Daemon Jul 19 05:59:48 garage-stereo sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 19 05:59:48 garage-stereo sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:48 garage-stereo volumio[790]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jul 19 05:59:48 garage-stereo sudo[1358]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:48 garage-stereo volumio[790]: error: Cannot start Volumio Streaming Daemon Jul 19 05:59:48 garage-stereo volumio[790]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 19 05:59:48 garage-stereo volumio[790]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 19 05:59:48 garage-stereo volumio[790]: info: succeeded Jul 19 05:59:48 garage-stereo volumio[790]: info: succeeded Jul 19 05:59:48 garage-stereo volumio[790]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 19 05:59:49 garage-stereo volumio[790]: info: MyVolumio token set successfully Jul 19 05:59:49 garage-stereo volumio[790]: info: MYVOLUMIO: Adding device Jul 19 05:59:49 garage-stereo volumio[790]: info: MYVOLUMIO: Evaluating Server Jul 19 05:59:50 garage-stereo volumio[790]: info: MyVolumio status changed Jul 19 05:59:50 garage-stereo volumio[790]: info: Streaming services startup Jul 19 05:59:50 garage-stereo volumio[790]: info: Starting Streaming Daemon Jul 19 05:59:50 garage-stereo volumio[790]: info: Removing browser output: myVolumio user plan is not superstar Jul 19 05:59:50 garage-stereo volumio[790]: info: Removing audio output: Jul 19 05:59:50 garage-stereo volumio[790]: info: Stoppping Tunnel 1 Jul 19 05:59:50 garage-stereo sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jul 19 05:59:50 garage-stereo sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:50 garage-stereo sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 19 05:59:50 garage-stereo sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 19 05:59:50 garage-stereo volumio[790]: info: Setting Geolocation for MyVolumio to us3 Jul 19 05:59:50 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:50 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:50 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:50 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:50 garage-stereo sudo[1383]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:50 garage-stereo volumio[790]: error: Cannot start Volumio Streaming Daemon Jul 19 05:59:50 garage-stereo volumio[790]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 19 05:59:50 garage-stereo volumio[790]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 19 05:59:50 garage-stereo sudo[1385]: pam_unix(sudo:session): session closed for user root Jul 19 05:59:50 garage-stereo volumio[790]: info: Remote SSH Stopped Jul 19 05:59:50 garage-stereo volumio[790]: STREAMING PROXY: Starting server on port 3245 Jul 19 05:59:50 garage-stereo volumio[790]: Node JS runtime: 14 Jul 19 05:59:51 garage-stereo volumio[790]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 19 05:59:51 garage-stereo volumio[790]: info: Updating MyVolumio device info Jul 19 05:59:51 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:51 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:51 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:51 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:51 garage-stereo volumio[790]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 19 05:59:52 garage-stereo volumio[997]: .........................................................................++++ Jul 19 05:59:52 garage-stereo volumio[997]: e is 65537 (0x010001) Jul 19 05:59:52 garage-stereo volumio[997]: writing RSA key Jul 19 05:59:55 garage-stereo volumio[790]: info: MYVOLUMIO: Adding device Jul 19 05:59:55 garage-stereo volumio[790]: info: MYVOLUMIO: Evaluating Server Jul 19 05:59:55 garage-stereo volumio[790]: info: Setting Geolocation for MyVolumio to us3 Jul 19 05:59:55 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:55 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:55 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:55 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:56 garage-stereo volumio[790]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jul 19 05:59:56 garage-stereo volumio[790]: info: Updating MyVolumio device info Jul 19 05:59:56 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:57 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:57 garage-stereo volumio[790]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jul 19 05:59:58 garage-stereo volumio[790]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 19 05:59:58 garage-stereo volumio[790]: info: Discovery: Getting this device information Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 05:59:58 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 19 05:59:58 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jul 19 05:59:58 garage-stereo volumio-remote-updater[474]: No test mode Jul 19 05:59:58 garage-stereo volumio-remote-updater[474]: No alpha test mode Jul 19 05:59:59 garage-stereo volumio[790]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n
    \n
  • Disable UI controls during DLNA playback
  • \n
  • Fix for Cast functionality halting due to memory filling up
  • \n
  • Fix for XML parsing on web-radio search
  • \n
\n

NEW ADDITIONS

\n
    \n
  • Add link for downloading CORRD in the side-menu
  • \n
\n","title":"Update v3.819","updateavailable":true} Jul 19 05:59:59 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jul 19 06:00:00 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 19 06:00:00 garage-stereo volumio[790]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 Jul 19 06:00:00 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 06:00:00 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 06:00:05 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 06:00:05 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 06:00:05 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 19 06:00:05 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jul 19 06:00:05 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 19 06:00:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jul 19 06:00:06 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetBrowseSources Jul 19 06:00:06 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 19 06:00:09 garage-stereo volumio[790]: error: MyVolumio Plugin failed to authenticate in a timely fashion Jul 19 06:00:09 garage-stereo volumio[790]: info: Completed starting MyVolumio Plugin Jul 19 06:00:09 garage-stereo volumio[790]: info: BOOT COMPLETED Jul 19 06:00:09 garage-stereo volumio[790]: [Metrics] CommandRouter: 87s 442.07ms Jul 19 06:00:09 garage-stereo volumio[790]: info: CoreCommandRouter::volumiosetStartupVolume Jul 19 06:00:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 19 06:00:09 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 19 06:00:10 garage-stereo volumio[790]: info: CoreCommandRouter::Close All Modals sent Jul 19 06:00:10 garage-stereo volumio[790]: info: CoreCommandRouter::Close All Modals sent Jul 19 06:00:10 garage-stereo sudo[1347]: pam_unix(sudo:session): session closed for user root Jul 19 06:00:10 garage-stereo sudo[1276]: pam_unix(sudo:session): session closed for user root Jul 19 06:00:10 garage-stereo volumio[790]: info: Uninstall script completed Jul 19 06:00:10 garage-stereo volumio[790]: info: Removing plugin music_services_shield from configuration Jul 19 06:00:11 garage-stereo volumio[790]: info: Successfully removed music_services_shield configuration files Jul 19 06:00:11 garage-stereo volumio[790]: info: Plugin folders cleanup Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning into folder /volumio/app/plugins/ Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category audio_interface Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category miscellanea Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category music_service Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category plugins.json Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category system_controller Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category user_interface Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning into folder /data/plugins/ Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category music_service Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category system_controller Jul 19 06:00:11 garage-stereo volumio[790]: info: Scanning category system_hardware Jul 19 06:00:11 garage-stereo volumio[790]: info: Cleaning folder for music_services_shield Jul 19 06:00:11 garage-stereo volumio[790]: info: Plugin folders cleanup completed Jul 19 06:00:11 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 19 06:00:11 garage-stereo volumio[790]: info: [{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.1.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"GPIO Buttons","name":"gpio-buttons","category":"system_hardware","version":"0.8.4","icon":"fa-microchip","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Pirate Audio","name":"pirateaudio","category":"system_hardware","version":"0.1.2","icon":"fa-television","isManuallyInstalled":false,"enabled":true,"active":true}] Jul 19 06:00:11 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 19 06:00:11 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jul 19 06:00:11 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 19 06:00:11 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jul 19 06:00:17 garage-stereo volumio[790]: info: Starting Uninstall of plugin system_controller - ampswitch Jul 19 06:00:17 garage-stereo volumio[790]: info: Uninstalling plugin ampswitch Jul 19 06:00:17 garage-stereo volumio[790]: info: [ASDebug] Port: 25 Jul 19 06:00:17 garage-stereo volumio[790]: info: [ASDebug] Inverted: false Jul 19 06:00:17 garage-stereo volumio[790]: info: [ASDebug] Delay: 720 Jul 19 06:00:23 garage-stereo volumiologrotate[468]: ls: cannot access '/var/log/samba/log.wb-GARAGE': No such file or directory Jul 19 06:00:23 garage-stereo volumiologrotate[468]: ls: cannot access 'STEREO': No such file or directory Jul 19 06:00:28 garage-stereo sudo[1504]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get update Jul 19 06:00:28 garage-stereo sudo[1504]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Jul 19 06:00:28 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 19 06:00:28 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 19 06:00:28 garage-stereo volumio[790]: info: Discovery: Getting this device information Jul 19 06:00:28 garage-stereo volumio[790]: info: CoreCommandRouter::volumioGetState Jul 19 06:00:28 garage-stereo volumio[790]: info: CorePlayQueue::getTrack 0 Jul 19 06:00:28 garage-stereo volumio[790]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 19 06:00:43 garage-stereo sudo[1504]: pam_unix(sudo:session): session closed for user root Jul 19 06:00:55 garage-stereo volumio[790]: info: Starting Uninstall of plugin system_controller - ampswitch Jul 19 06:00:55 garage-stereo volumio[790]: info: Uninstalling plugin ampswitch Jul 19 06:00:55 garage-stereo volumio[790]: info: [ASDebug] Port: 25 Jul 19 06:00:55 garage-stereo volumio[790]: info: [ASDebug] Inverted: false Jul 19 06:00:55 garage-stereo volumio[790]: info: [ASDebug] Delay: 720 Jul 19 06:00:55 garage-stereo volumio[790]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 06:00:55 garage-stereo volumio[790]: Error: EBADF: bad file descriptor, close Jul 19 06:00:55 garage-stereo volumio[790]: at Object.closeSync (fs.js:439:3) Jul 19 06:00:55 garage-stereo volumio[790]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) Jul 19 06:00:55 garage-stereo volumio[790]: at Object. (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) Jul 19 06:00:55 garage-stereo volumio[790]: at Object.closeSync (/data/plugins/system_hardware/gpio-buttons/node_modules/graceful-fs/graceful-fs.js:51:27) Jul 19 06:00:55 garage-stereo volumio[790]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) Jul 19 06:00:55 garage-stereo volumio[790]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) Jul 19 06:00:55 garage-stereo volumio[790]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) Jul 19 06:00:55 garage-stereo volumio[790]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jul 19 06:00:55 garage-stereo volumio[790]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) Jul 19 06:00:55 garage-stereo volumio[790]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1459:22) Jul 19 06:00:55 garage-stereo volumio[790]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1218:45) Jul 19 06:00:55 garage-stereo volumio[790]: at Socket.emit (events.js:315:20) Jul 19 06:00:55 garage-stereo volumio[790]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jul 19 06:00:55 garage-stereo volumio[790]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jul 19 06:00:55 garage-stereo volumio[790]: errno: -9, Jul 19 06:00:55 garage-stereo volumio[790]: syscall: 'close', Jul 19 06:00:55 garage-stereo volumio[790]: code: 'EBADF' Jul 19 06:00:55 garage-stereo volumio[790]: } Jul 19 06:00:55 garage-stereo volumio[790]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 19 06:00:57 garage-stereo sudo[1714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-19 05:59 Jul 19 06:00:57 garage-stereo sudo[1714]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"