Jun 02 13:58:09 mn5 go-librespot[31968]: time="2026-06-02T13:58:09-06:00" level=error msg="did not receive last pong from dealer, 4440s passed" Jun 02 13:58:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:58:22 mn5 volumio[1283]: info: Received Get System Info Jun 02 13:58:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 13:58:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 13:58:22 mn5 volumio[1283]: info: Discovery: Getting this device information Jun 02 13:58:22 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:58:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 13:58:31 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:58:33 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:58:33 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 02 13:58:36 mn5 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 13:58:38 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:58:38 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 02 13:58:39 mn5 go-librespot[31968]: time="2026-06-02T13:58:39-06:00" level=error msg="did not receive last pong from dealer, 4470s passed" Jun 02 13:58:40 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:58:56 mn5 go-librespot[31968]: time="2026-06-02T13:58:56-06:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 456" Jun 02 13:58:56 mn5 go-librespot[31968]: time="2026-06-02T13:58:56-06:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 3689" Jun 02 13:58:57 mn5 go-librespot[31968]: time="2026-06-02T13:58:57-06:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 2374" Jun 02 13:59:04 mn5 go-librespot[31968]: time="2026-06-02T13:59:04-06:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 306" Jun 02 13:59:07 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:59:07 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 02 13:59:09 mn5 go-librespot[31968]: time="2026-06-02T13:59:09-06:00" level=error msg="did not receive last pong from dealer, 4500s passed" Jun 02 13:59:11 mn5 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 13:59:12 mn5 volumio[1283]: info: CALLMETHOD: music_service spop logout Jun 02 13:59:12 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: spop , logout Jun 02 13:59:12 mn5 volumio[1283]: info: Deleting Spotify credentials File Jun 02 13:59:12 mn5 volumio[1283]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Jun 02 13:59:12 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 13:59:13 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:13 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:13 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:13 mn5 sudo[15976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:13 mn5 sudo[15976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:13 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:13 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:13 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:13 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:13 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:13 mn5 systemd[1]: go-librespot-daemon.service: Consumed 3min 8.800s CPU time. Jun 02 13:59:13 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:13 mn5 go-librespot[15978]: go-librespot daemon starting... Jun 02 13:59:13 mn5 sudo[15976]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=debug msg="no app state found" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=debug msg="stored credentials not found" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=info msg="generated new device id: 8e9a3b7839ea296c6f9a8dcae6ca4309c67d7e26" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=info msg="zeroconf server listening on port 35331" Jun 02 13:59:13 mn5 go-librespot[15979]: time="2026-06-02T13:59:13-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 13:59:14 mn5 volumio[1283]: info: CALLMETHOD: music_service spop logout Jun 02 13:59:14 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: spop , logout Jun 02 13:59:14 mn5 volumio[1283]: info: Deleting Spotify credentials File Jun 02 13:59:14 mn5 volumio[1283]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesSpotify Jun 02 13:59:14 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 13:59:15 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:15 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:15 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:15 mn5 sudo[15991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:15 mn5 sudo[15991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:15 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:15 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:15 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:15 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:15 mn5 go-librespot[15993]: go-librespot daemon starting... Jun 02 13:59:15 mn5 sudo[15991]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=debug msg="no app state found" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=debug msg="stored credentials not found" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=info msg="generated new device id: 2c990fbc4a980214d75f388d9a477e10f4c44a5b" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=info msg="zeroconf server listening on port 33917" Jun 02 13:59:15 mn5 go-librespot[15994]: time="2026-06-02T13:59:15-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 13:59:16 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:16 mn5 go-librespot[15994]: time="2026-06-02T13:59:16-06:00" level=debug msg="new websocket client" Jun 02 13:59:16 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:16 mn5 volumio[1283]: info: go-librespot daemon successfully initialized Jun 02 13:59:18 mn5 volumio[1283]: info: go-librespot daemon successfully initialized Jun 02 13:59:19 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:19 mn5 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 02 13:59:19 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:19 mn5 volumio[1283]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jun 02 13:59:19 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:19 mn5 go-librespot[15994]: time="2026-06-02T13:59:19-06:00" level=debug msg="new websocket client" Jun 02 13:59:19 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:20 mn5 volumio[1283]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Jun 02 13:59:20 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Jun 02 13:59:20 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:20 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:20 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:20 mn5 sudo[16019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:20 mn5 sudo[16019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:20 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:20 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:20 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:20 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:20 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:20 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:20 mn5 go-librespot[16021]: go-librespot daemon starting... Jun 02 13:59:20 mn5 sudo[16019]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=debug msg="app state loaded" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=debug msg="stored credentials not found" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=info msg="zeroconf server listening on port 46085" Jun 02 13:59:20 mn5 go-librespot[16022]: time="2026-06-02T13:59:20-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 13:59:21 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:21 mn5 go-librespot[16022]: time="2026-06-02T13:59:21-06:00" level=debug msg="new websocket client" Jun 02 13:59:21 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:22 mn5 volumio[1283]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Jun 02 13:59:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Jun 02 13:59:22 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:22 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:22 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:22 mn5 sudo[16032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:22 mn5 sudo[16032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:22 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:22 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:22 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:22 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:22 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:22 mn5 go-librespot[16034]: go-librespot daemon starting... Jun 02 13:59:22 mn5 sudo[16032]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=debug msg="app state loaded" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=debug msg="stored credentials not found" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:22 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:22 mn5 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 02 13:59:22 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:22 mn5 volumio[1283]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=info msg="zeroconf server listening on port 35675" Jun 02 13:59:22 mn5 go-librespot[16035]: time="2026-06-02T13:59:22-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 13:59:23 mn5 volumio[1283]: info: go-librespot daemon successfully initialized Jun 02 13:59:24 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:24 mn5 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 02 13:59:24 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:24 mn5 volumio[1283]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jun 02 13:59:25 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:25 mn5 go-librespot[16035]: time="2026-06-02T13:59:25-06:00" level=debug msg="new websocket client" Jun 02 13:59:25 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:25 mn5 volumio[1283]: info: go-librespot daemon successfully initialized Jun 02 13:59:26 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:26 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:26 mn5 go-librespot[16035]: time="2026-06-02T13:59:26-06:00" level=debug msg="new websocket client" Jun 02 13:59:27 mn5 volumio[1283]: info: Received OAUTH Data Jun 02 13:59:27 mn5 volumio[1283]: info: Executing Spotify Oauth Login Jun 02 13:59:27 mn5 volumio[1283]: info: Saving Spotify Refresh Token Jun 02 13:59:27 mn5 sudo[16044]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 13:59:27 mn5 sudo[16044]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:27 mn5 sudo[16044]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:27 mn5 sudo[16046]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 13:59:27 mn5 sudo[16046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:27 mn5 sudo[16046]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:27 mn5 volumio[1283]: verbose: New Socket.io Connection to 10.20.51.190 from 10.20.127.161 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 02 13:59:27 mn5 volumio[1283]: info: New Spotify access tokenBQDSSmmioW... Jun 02 13:59:27 mn5 volumio[1283]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 13:59:28 mn5 volumio[1283]: info: Received Get System Info Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 13:59:28 mn5 volumio[1283]: info: Discovery: Getting this device information Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:28 mn5 volumio[1283]: info: Listing playlists Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 13:59:28 mn5 volumio[1283]: SPOTIFY: User informations: {"account_id":"nHQXbVyyAZ","country":"MX","display_name":"Vero Diaz Shugert","email":"verodiaz1@live.com.mx","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1291375412"},"followers":{"href":null,"total":16},"href":"https://api.spotify.com/v1/users/1291375412","id":"1291375412","images":[{"height":300,"url":"https://scontent-ord5-3.xx.fbcdn.net/v/t1.6435-1/51915458_2230267263698137_2626835559108050944_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=100&ccb=1-7&_nc_sid=08baa4&_nc_ohc=r8nf-gJOXFIQ7kNvwFC8uvZ&_nc_oc=AdpSEj2_7mb0bfgOSiy3Lfp8GDivkJEwSgE1jLdWh8iyNuAJZZMPOZxZT7QfxHoBav1Cmo2Iq7fRV71ldWJ4VPbJ&_nc_zt=24&_nc_ht=scontent-ord5-3.xx&edm=AP4hL3IEAAAA&_nc_gid=c3PG1ms8-zW1azBupwOXhw&_nc_tpa=Q5bMBQHHo623Sazq0Sb849Z2c7E2BqrDJcwWuySMGEO4CZk_B93D7ZiHZ3WLnNj9tcYU65aD5l0G&oh=00_Af_YL5nUwe_DGQllGiBTtLWwwGnyY-hP_7ypVow2BRbtIg&oe=6A463464","width":300},{"height":64,"url":"https://scontent-ord5-3.xx.fbcdn.net/v/t1.6435-1/51915458_2230267263698137_2626835559108050944_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=100&ccb=1-7&_nc_sid=28885b&_nc_ohc=r8nf-gJOXFIQ7kNvwFC8uvZ&_nc_oc=AdpSEj2_7mb0bfgOSiy3Lfp8GDivkJEwSgE1jLdWh8iyNuAJZZMPOZxZT7QfxHoBav1Cmo2Iq7fRV71ldWJ4VPbJ&_nc_zt=24&_nc_ht=scontent-ord5-3.xx&edm=AP4hL3IEAAAA&_nc_gid=c3PG1ms8-zW1azBupwOXhw&_nc_tpa=Q5bMBQHvcwxdf5NtLjh5eMp4OScK7pIVKEW3Yv-_kSZuPzCF2HJRqiF75q4GDqqxi36uDDmSEmKh&oh=00_Af9kMvJf7T33_Jmx7a7m_qM6sxDPzNI9j4cKHUZ1q7qf7Q&oe=6A463464","width":64}],"product":"premium","type":"user","uri":"spotify:user:1291375412"} Jun 02 13:59:28 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:28 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:28 mn5 sudo[16050]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:28 mn5 sudo[16050]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:28 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:28 mn5 systemd[1]: go-librespot-daemon.service: Killing process 16040 (go-librespot) with signal SIGKILL. Jun 02 13:59:28 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:28 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:28 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:28 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:28 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:28 mn5 go-librespot[16052]: go-librespot daemon starting... Jun 02 13:59:28 mn5 sudo[16050]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="app state loaded" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="stored credentials not found" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=info msg="zeroconf server listening on port 39683" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Jun 02 13:59:28 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:28 mn5 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:28 mn5 volumio[1283]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jun 02 13:59:28 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="new websocket client" Jun 02 13:59:28 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="obtained new client token: AAD4bCGcglGw3YWxOyZ3Ucz4mOYdEwfARdq4Vu35ef9JSJ4Y2O0PQ1vx6rSjnADS4EATch4lx9nguX/hwmwsXZu8C4i+x2BS4SL8UR6ejAlHEwrapv/WB/hIDDSqbK24rUamZwBcPju4qHMIwDnvRr5nUr/TgN4EIlizlC9sShLM3RPpIb/SG769fgooOSjycP3+qP3+ZmXboSZDFj8VX+1pnOi8DDuSayMQIZ3FAPbyhLd8uBKyhjiirm4=" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="connected to ap-guc3.spotify.com:4070" Jun 02 13:59:28 mn5 volumio[1283]: info: New Spotify access tokenBQAY68xUML... Jun 02 13:59:28 mn5 volumio[1283]: info: Spotify credentials grant success - running version from March 24, 2019 Jun 02 13:59:28 mn5 volumio[1283]: SPOTIFY: User informations: {"account_id":"nHQXbVyyAZ","country":"MX","display_name":"Vero Diaz Shugert","email":"verodiaz1@live.com.mx","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1291375412"},"followers":{"href":null,"total":16},"href":"https://api.spotify.com/v1/users/1291375412","id":"1291375412","images":[{"height":300,"url":"https://scontent-ord5-3.xx.fbcdn.net/v/t1.6435-1/51915458_2230267263698137_2626835559108050944_n.jpg?stp=dst-jpg_s320x320_tt6&_nc_cat=100&ccb=1-7&_nc_sid=08baa4&_nc_ohc=r8nf-gJOXFIQ7kNvwFC8uvZ&_nc_oc=AdpSEj2_7mb0bfgOSiy3Lfp8GDivkJEwSgE1jLdWh8iyNuAJZZMPOZxZT7QfxHoBav1Cmo2Iq7fRV71ldWJ4VPbJ&_nc_zt=24&_nc_ht=scontent-ord5-3.xx&edm=AP4hL3IEAAAA&_nc_gid=c3PG1ms8-zW1azBupwOXhw&_nc_tpa=Q5bMBQHHo623Sazq0Sb849Z2c7E2BqrDJcwWuySMGEO4CZk_B93D7ZiHZ3WLnNj9tcYU65aD5l0G&oh=00_Af_YL5nUwe_DGQllGiBTtLWwwGnyY-hP_7ypVow2BRbtIg&oe=6A463464","width":300},{"height":64,"url":"https://scontent-ord5-3.xx.fbcdn.net/v/t1.6435-1/51915458_2230267263698137_2626835559108050944_n.jpg?stp=cp0_dst-jpg_s50x50_tt6&_nc_cat=100&ccb=1-7&_nc_sid=28885b&_nc_ohc=r8nf-gJOXFIQ7kNvwFC8uvZ&_nc_oc=AdpSEj2_7mb0bfgOSiy3Lfp8GDivkJEwSgE1jLdWh8iyNuAJZZMPOZxZT7QfxHoBav1Cmo2Iq7fRV71ldWJ4VPbJ&_nc_zt=24&_nc_ht=scontent-ord5-3.xx&edm=AP4hL3IEAAAA&_nc_gid=c3PG1ms8-zW1azBupwOXhw&_nc_tpa=Q5bMBQHvcwxdf5NtLjh5eMp4OScK7pIVKEW3Yv-_kSZuPzCF2HJRqiF75q4GDqqxi36uDDmSEmKh&oh=00_Af9kMvJf7T33_Jmx7a7m_qM6sxDPzNI9j4cKHUZ1q7qf7Q&oe=6A463464","width":64}],"product":"premium","type":"user","uri":"spotify:user:1291375412"} Jun 02 13:59:28 mn5 volumio[1283]: info: Spotify Successfully logged in Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 13:59:28 mn5 volumio[1283]: info: [1780430368956] CoreMusicLibrary::Adding element Spotify Jun 02 13:59:28 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 13:59:28 mn5 volumio[1283]: Cannot find translation for source Spotify Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="completed keyexchange" Jun 02 13:59:28 mn5 go-librespot[16053]: time="2026-06-02T13:59:28-06:00" level=debug msg="completed challenge" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=info msg="authenticated AP" username="12******12" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=info msg="authenticated Login5" username="12******12" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="stored credentials" username="12******12" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="initializing zeroconf session" username="12******12" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="dealer connection opened" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=trace msg="starting accesspoint recv loop" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=trace msg="starting dealer recv loop" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=trace msg="received accesspoint ping" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 02 13:59:29 mn5 volumio[1283]: info: Spotify volume: 100 Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="received connection id: OTg2MTg3YmMtMDYx...Q0JEMjU1ODBBNg==" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=trace msg="received accesspoint pong ack" Jun 02 13:59:29 mn5 go-librespot[16053]: time="2026-06-02T13:59:29-06:00" level=debug msg="put connect state because NEW_DEVICE" Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 02 13:59:29 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:29 mn5 volumio[1283]: info: Spotify volume: 100 Jun 02 13:59:29 mn5 volumio[1283]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:29 mn5 volumio[1283]: SPOTIFY: RECEIVED VOLUMIO VOLUME 11 Jun 02 13:59:29 mn5 volumio[1283]: SPOTIFY: SPOTIFY VOLUME 100 Jun 02 13:59:29 mn5 volumio[1283]: SPOTIFY: VOLUMIO VOLUME 11 Jun 02 13:59:29 mn5 volumio[1283]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 13:59:29 mn5 volumio[1283]: info: Setting Spotify Volume from Volumio: 11 Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:59:29 mn5 volumio[1283]: info: Received Get System Info Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 13:59:29 mn5 volumio[1283]: info: Discovery: Getting this device information Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:29 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 13:59:30 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 13:59:30 mn5 volumio[1283]: info: Received Get System Info Jun 02 13:59:30 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 13:59:30 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 13:59:30 mn5 volumio[1283]: info: Discovery: Getting this device information Jun 02 13:59:30 mn5 volumio[1283]: info: CoreCommandRouter::volumioGetState Jun 02 13:59:30 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 13:59:31 mn5 volumio[1283]: info: Initializing connection to go-librespot Websocket Jun 02 13:59:31 mn5 go-librespot[16053]: time="2026-06-02T13:59:31-06:00" level=debug msg="new websocket client" Jun 02 13:59:31 mn5 volumio[1283]: info: Connection to go-librespot Websocket established Jun 02 13:59:31 mn5 volumio[1283]: info: go-librespot daemon successfully initialized Jun 02 13:59:31 mn5 volumio[1283]: SPOTIFY: SETTING SPOTIFY VOLUME 11 Jun 02 13:59:31 mn5 volumio[1283]: info: Sending Spotify command with payload to local API: /player/volume Jun 02 13:59:31 mn5 go-librespot[16053]: time="2026-06-02T13:59:31-06:00" level=debug msg="update volume requested to 7208/65535" Jun 02 13:59:31 mn5 volumio[1283]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Jun 02 13:59:31 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Jun 02 13:59:31 mn5 volumio[1283]: info: Creating Spotify config file Jun 02 13:59:31 mn5 volumio[1283]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 13:59:31 mn5 volumio[1283]: info: Spotify config file written Jun 02 13:59:31 mn5 sudo[16077]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jun 02 13:59:31 mn5 sudo[16077]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:31 mn5 systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Jun 02 13:59:31 mn5 systemd[1]: go-librespot-daemon.service: Killing process 16057 (go-librespot) with signal SIGKILL. Jun 02 13:59:31 mn5 systemd[1]: go-librespot-daemon.service: Deactivated successfully. Jun 02 13:59:31 mn5 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:31 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:31 mn5 volumio[1283]: info: Connection to go-librespot Websocket closed Jun 02 13:59:31 mn5 volumio[1283]: info: Getting Spotify volume Jun 02 13:59:31 mn5 volumio[1283]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 13:59:31 mn5 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jun 02 13:59:31 mn5 go-librespot[16079]: go-librespot daemon starting... Jun 02 13:59:31 mn5 sudo[16077]: pam_unix(sudo:session): session closed for user root Jun 02 13:59:31 mn5 volumio[1283]: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 02 13:59:31 mn5 volumio[1283]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Jun 02 13:59:31 mn5 volumio[1283]: errno: -111, Jun 02 13:59:31 mn5 volumio[1283]: code: 'ECONNREFUSED', Jun 02 13:59:31 mn5 volumio[1283]: syscall: 'connect', Jun 02 13:59:31 mn5 volumio[1283]: address: '127.0.0.1', Jun 02 13:59:31 mn5 volumio[1283]: port: 9879, Jun 02 13:59:31 mn5 volumio[1283]: response: undefined Jun 02 13:59:31 mn5 volumio[1283]: } Jun 02 13:59:31 mn5 volumio[1283]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=info msg="running go-librespot 0.7.1" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=debug msg="app state loaded" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Jun 02 13:59:31 mn5 sudo[16102]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-02 13:58' Jun 02 13:59:31 mn5 sudo[16102]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=info msg="zeroconf server listening on port 46273" Jun 02 13:59:31 mn5 go-librespot[16080]: time="2026-06-02T13:59:31-06:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"