-- 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
\nNEW 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"