Feb 26 02:34:00 volumio go-librespot[1653201]: time="2026-02-26T02:34:00+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:00 volumio go-librespot[1653201]: time="2026-02-26T02:34:00+07:00" level=debug msg="completed challenge" Feb 26 02:34:00 volumio go-librespot[1653201]: time="2026-02-26T02:34:00+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Feb 26 02:34:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:04 volumio go-librespot[1653211]: go-librespot daemon starting... Feb 26 02:34:04 volumio go-librespot[1653212]: time="2026-02-26T02:34:04+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:04 volumio go-librespot[1653212]: time="2026-02-26T02:34:04+07:00" level=debug msg="app state loaded" Feb 26 02:34:04 volumio go-librespot[1653212]: time="2026-02-26T02:34:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:04 volumio volumio[1652622]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 26 02:34:04 volumio volumio[1652622]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 26 02:34:04 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:34:04 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=info msg="zeroconf server listening on port 41737" Feb 26 02:34:05 volumio volumio[1652622]: info: Starting MyVolumio Remote Streaming Endpoints Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="obtained new client token: AAAJwpxBmYwfGmW1jOzIoQxSf7OUTxJXgA+r8TDBYKBPPKdRziniuZkOISc2/ILP8vCan3/cyV3b2lIx83M/gtpJ7cmgds8/UeWJC6CEk8wO1Dwo1qnZ1d4TZotudt9BW197I2AZ0tD2PUT8O3sXtL4KZM3ZNMxZqLeRyTiAd9JnbuWBGqrayf2ac68um0RQDvBbcuTDT5y/LuMIZypKYQi8t3+MZATv4i6OzzgL0qfY7S3pXl180iMJ" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=debug msg="completed challenge" Feb 26 02:34:05 volumio go-librespot[1653212]: time="2026-02-26T02:34:05+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:06 volumio volumio[1652622]: info: MyVolumio login type: Token Feb 26 02:34:07 volumio volumio[1652622]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 26 02:34:07 volumio volumio[1652622]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 26 02:34:08 volumio volumio-remote-updater[666]: [2026-02-26 02:34:08] [connect] Successful connection Feb 26 02:34:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Feb 26 02:34:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:09 volumio go-librespot[1653237]: go-librespot daemon starting... Feb 26 02:34:09 volumio go-librespot[1653238]: time="2026-02-26T02:34:09+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:09 volumio go-librespot[1653238]: time="2026-02-26T02:34:09+07:00" level=debug msg="app state loaded" Feb 26 02:34:09 volumio go-librespot[1653238]: time="2026-02-26T02:34:09+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=info msg="zeroconf server listening on port 44693" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=debug msg="obtained new client token: AAAu94CbmNPdOpykWQ2vs9PKehWf9/CsOvKKJHAYXZWw7ll20+fnGWdQqRRo8G1KnX7pKVMttbqFlKJG9IcYRuSIiUNV+K6lvfgQ8SguufvHyUWJNRgsQH2ZNx1R/qJ2PIBqTRwErG9IlOsgibXAcTpA9HhV3j/iP9/vbeqAdhqx4l81IVZnAUc44uYO11runSz40WFTbPla8FMWl0vFmhFwwyBB4+YIUsb0seOpS/2ozovRvq3x8suqQKc=" Feb 26 02:34:10 volumio go-librespot[1653238]: time="2026-02-26T02:34:10+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:11 volumio go-librespot[1653238]: time="2026-02-26T02:34:11+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:11 volumio go-librespot[1653238]: time="2026-02-26T02:34:11+07:00" level=debug msg="completed challenge" Feb 26 02:34:11 volumio go-librespot[1653238]: time="2026-02-26T02:34:11+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Feb 26 02:34:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:15 volumio go-librespot[1653250]: go-librespot daemon starting... Feb 26 02:34:15 volumio go-librespot[1653251]: time="2026-02-26T02:34:15+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:15 volumio go-librespot[1653251]: time="2026-02-26T02:34:15+07:00" level=debug msg="app state loaded" Feb 26 02:34:15 volumio go-librespot[1653251]: time="2026-02-26T02:34:15+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=info msg="zeroconf server listening on port 34941" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=debug msg="obtained new client token: AADLdlm3RuA0UguvuMWW7k899xYcr+wP8jpjRstnLQD00To8OPOlixtTUZa9dLAIPI8GfIRmW6oOFyjeVZ8hillD9ndcDseDgcn3B2eaOUhfYHZMiZ/7GRnnUTN/Ebs2P4VQcKbXbgaB8QXX77e5wRnavH1bmxxO4gY7dvuYnM3pa6EH2JPYj2BjiIFmSJGscsgwKjmy36iy9JvWAnRZg90R9um+LAN2r2VwIR0CfLxhmd9OES2Wjn/lxzI=" Feb 26 02:34:17 volumio go-librespot[1653251]: time="2026-02-26T02:34:17+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:18 volumio go-librespot[1653251]: time="2026-02-26T02:34:18+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:18 volumio go-librespot[1653251]: time="2026-02-26T02:34:18+07:00" level=debug msg="completed challenge" Feb 26 02:34:18 volumio go-librespot[1653251]: time="2026-02-26T02:34:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:19 volumio volumio[1652622]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 26 02:34:19 volumio volumio[1652622]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 26 02:34:19 volumio volumio[1652622]: info: Streaming services startup Feb 26 02:34:19 volumio volumio[1652622]: info: Starting Streaming Daemon Feb 26 02:34:20 volumio volumio[1652622]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 26 02:34:20 volumio sudo[1653275]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 26 02:34:20 volumio sudo[1653275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:34:21 volumio sudo[1653275]: pam_unix(sudo:session): session closed for user root Feb 26 02:34:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Feb 26 02:34:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:22 volumio go-librespot[1653283]: go-librespot daemon starting... Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=debug msg="app state loaded" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:34:22 volumio go-librespot[1653284]: time="2026-02-26T02:34:22+07:00" level=info msg="zeroconf server listening on port 35041" Feb 26 02:34:23 volumio go-librespot[1653284]: time="2026-02-26T02:34:23+07:00" level=debug msg="obtained new client token: AAAXTULPtdzpCgACnrZhnf36ALrpDPb30TLXTgXqKsVVXE/w28FeYDUbhPbFlmRhWy8qnXs9wh59JMaG/Pe/O/G+h8GKxdkgBujg6uuGvkvCzWhRcmGKaTEuaiQIWwnNzLsWTDZMijZzXip39HJYYpib+0tLmqoQyoOTKOKlfPc+8WfzCQ7lA70qYOjYPmygpo/eGdFsXxr7+fHmTiv1IXBEHI9T3wjPJGiyxG1KwoAi8XbZlParV3xU" Feb 26 02:34:23 volumio go-librespot[1653284]: time="2026-02-26T02:34:23+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:23 volumio go-librespot[1653284]: time="2026-02-26T02:34:23+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:23 volumio go-librespot[1653284]: time="2026-02-26T02:34:23+07:00" level=debug msg="completed challenge" Feb 26 02:34:23 volumio volumio-remote-updater[666]: [2026-02-26 02:34:23] [connect] Successful connection Feb 26 02:34:23 volumio go-librespot[1653284]: time="2026-02-26T02:34:23+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:26 volumio volumio[1652622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 26 02:34:27 volumio volumio[1652622]: info: camilladsp respawn in 100 ms (attempt 1/10) Feb 26 02:34:27 volumio volumio[1652622]: info: BOOT COMPLETED Feb 26 02:34:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Feb 26 02:34:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:28 volumio go-librespot[1653298]: go-librespot daemon starting... Feb 26 02:34:28 volumio go-librespot[1653310]: time="2026-02-26T02:34:28+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:28 volumio go-librespot[1653310]: time="2026-02-26T02:34:28+07:00" level=debug msg="app state loaded" Feb 26 02:34:28 volumio go-librespot[1653310]: time="2026-02-26T02:34:28+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=info msg="zeroconf server listening on port 33147" Feb 26 02:34:29 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:34:29 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=debug msg="obtained new client token: AACsXT5RJgSsFO2kJI1bmo62gzJDQND8M+yv+kxIlM14LQERkojjVY2clF0uEZOTBLTpULY3vZlO76Sc2bxVG0gXfz5q3EaA8KpDJaw2uKtgISv5eW9jSQprcIndSkVXO/dah4lw4GTxGEZIzU2tM3f0PsoRFr0d/hoD4Gn7cALeCDyNaYZ5eyd2IjH4nAKLTVHVUs1xT/bmb1aut+3xBHvRJMWUsoHbTZFcMwxxhtCysmcBCo91TMnvSZY=" Feb 26 02:34:29 volumio go-librespot[1653310]: time="2026-02-26T02:34:29+07:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Feb 26 02:34:30 volumio go-librespot[1653310]: time="2026-02-26T02:34:30+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:34:30 volumio go-librespot[1653310]: time="2026-02-26T02:34:30+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:30 volumio go-librespot[1653310]: time="2026-02-26T02:34:30+07:00" level=debug msg="completed challenge" Feb 26 02:34:30 volumio go-librespot[1653310]: time="2026-02-26T02:34:30+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetBrowseSources Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 02:34:31 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 26 02:34:31 volumio volumio[1652622]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 26 02:34:31 volumio volumio[1652622]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 26 02:34:31 volumio volumio[1652622]: info: camilladsp service terminated, instance 1 Feb 26 02:34:31 volumio volumio[1652622]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 26 02:34:32 volumio volumio[1652622]: info: camilladsp service started and running in background, instance 1 Feb 26 02:34:32 volumio volumio[1652622]: info: Starting Shairport Sync Feb 26 02:34:32 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:34:32 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:34:33 volumio sudo[1653323]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 26 02:34:33 volumio sudo[1653323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:34:33 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 26 02:34:33 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 26 02:34:33 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 02:34:33 volumio systemd[1]: shairport-sync.service: Consumed 2.346s CPU time. Feb 26 02:34:33 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 26 02:34:33 volumio sudo[1653323]: pam_unix(sudo:session): session closed for user root Feb 26 02:34:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Feb 26 02:34:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:34 volumio go-librespot[1653337]: go-librespot daemon starting... Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=debug msg="app state loaded" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:34:34 volumio go-librespot[1653338]: time="2026-02-26T02:34:34+07:00" level=info msg="zeroconf server listening on port 46613" Feb 26 02:34:35 volumio go-librespot[1653338]: time="2026-02-26T02:34:35+07:00" level=debug msg="obtained new client token: AADb9Ov3Q0JixogyPJldE5LT0s1DBkTDwbWEK2uPaY/gHpnO61Ap3+sesnsvyG9opLO+sT4D4YQI8GUhjjMF1nRwlzNKj83CkEGdwbqziDK47gqgznGOjVCxTFxA3Zsux6pLf498zddr5pMVlLtd+viMqc3p4GeciMN+8/upF//K4ITdBNMNKhhLnGrOC/W/F41mpYF4IhTiyIfxScemv/eGVyAllB0fsrNjGDDFmxB0g+JVHvMy3VX4" Feb 26 02:34:35 volumio go-librespot[1653338]: time="2026-02-26T02:34:35+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:35 volumio go-librespot[1653338]: time="2026-02-26T02:34:35+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:35 volumio go-librespot[1653338]: time="2026-02-26T02:34:35+07:00" level=debug msg="completed challenge" Feb 26 02:34:35 volumio go-librespot[1653338]: time="2026-02-26T02:34:35+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:38 volumio volumio-remote-updater[666]: [2026-02-26 02:34:38] [connect] Successful connection Feb 26 02:34:39 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:34:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Feb 26 02:34:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:40 volumio go-librespot[1653376]: go-librespot daemon starting... Feb 26 02:34:40 volumio volumio[1652622]: error: Cannot start Volumio Streaming Daemon Feb 26 02:34:40 volumio volumio[1652622]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 26 02:34:40 volumio volumio[1652622]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 26 02:34:40 volumio go-librespot[1653377]: time="2026-02-26T02:34:40+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:40 volumio go-librespot[1653377]: time="2026-02-26T02:34:40+07:00" level=debug msg="app state loaded" Feb 26 02:34:40 volumio go-librespot[1653377]: time="2026-02-26T02:34:40+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=info msg="zeroconf server listening on port 43251" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=debug msg="obtained new client token: AACtpXfdovI4nKgHaUBsRBSmiqVrJmV0wM4zWRI3FpwKpRFmifEOEKWYSO+A6S2t45P9z+Wz+ynu6mMjaktJ0LbWbrJHwSn9TyXcykNWpjCVWvyH+rWTx6hgxwFYZB81e79Baz1JzV4RGrTulXPJff8yrucg4oHfw2O68ogDqhgmIHKgXm8h5VxD3MwNf43QlvJzqgvHQ3tjmnHUMmjc7IG6NJN7PSLimc/SAj6EDiTdBbPskc5ktcRHZJY=" Feb 26 02:34:41 volumio go-librespot[1653377]: time="2026-02-26T02:34:41+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:42 volumio go-librespot[1653377]: time="2026-02-26T02:34:42+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:42 volumio go-librespot[1653377]: time="2026-02-26T02:34:42+07:00" level=debug msg="completed challenge" Feb 26 02:34:42 volumio go-librespot[1653377]: time="2026-02-26T02:34:42+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:43 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:34:43 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:34:44 volumio volumio[1652622]: info: Shairport-Sync Started Feb 26 02:34:44 volumio volumio[1652622]: info: camilladsp respawn in 100 ms (attempt 1/10) Feb 26 02:34:44 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:34:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Feb 26 02:34:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:46 volumio go-librespot[1653395]: go-librespot daemon starting... Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=debug msg="app state loaded" Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:46 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:46+07:00" level=info msg="zeroconf server listening on port 39397" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:47+07:00" level=debug msg="obtained new client token: AACQwE0NAik0l1upSqmFBEgveq/h9J3Qx4yQieM8RKaLqHE6CB7cPaR/7vRv+7OAf0j97ATOuroLFaBTLNfP9OHbSB4gFS5ZHs9mP921i3wt1bEUGcayY9XWZe1+askQ2dfyGgY6875FqwtfxjHd+0GLYe7RQ3OLexnhlYcdqEuMB3S4pYSXDl9X6SBHwh/l3nBG2ZFnANa9FFUYzyqdOo1PC2+OiWg/h8DEbB65W8o6LTFUHvg5FNpW" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:47+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:47+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:47+07:00" level=debug msg="completed challenge" Feb 26 02:34:47 volumio go-librespot[1653396]: time="2026-02-26T02:34:47+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:48 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:34:51 volumio volumio[1652622]: info: camilladsp respawn in 200 ms (attempt 2/10) Feb 26 02:34:51 volumio volumio[1652622]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Feb 26 02:34:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Feb 26 02:34:51 volumio volumio[1652622]: info: Retrying Login Due to Network Error Feb 26 02:34:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:51 volumio go-librespot[1653421]: go-librespot daemon starting... Feb 26 02:34:51 volumio volumio[1652622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 26 02:34:51 volumio go-librespot[1653422]: time="2026-02-26T02:34:51+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:51 volumio go-librespot[1653422]: time="2026-02-26T02:34:51+07:00" level=debug msg="app state loaded" Feb 26 02:34:51 volumio go-librespot[1653422]: time="2026-02-26T02:34:51+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:51 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=info msg="zeroconf server listening on port 43295" Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=debug msg="obtained new client token: AAAhR1dG6BBQa0uQ/mGA/RE6SGQb+u5m7yFc03fXYEw2XcwKN7mS2tz4tEONQINbPIwPONZumeRc0jOY3tr/OIgL+sK2d5d5KJhX9C6ZmiEqKfWnhjCI5FcUEv7VAU9jzhGZLyD+B2nMWmmiLPaWB9lTh8lsz6/MTtqBngmlZbKiF0YuyTkeNXwmcSpWaAhxczWLletTMN5o9B184FZa7rCxQaioxYXLMmWKkgDVR5enSkbd6NrBX8xFkT0=" Feb 26 02:34:53 volumio go-librespot[1653422]: time="2026-02-26T02:34:53+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:34:53 volumio volumio-remote-updater[666]: [2026-02-26 02:34:53] [connect] Successful connection Feb 26 02:34:54 volumio go-librespot[1653422]: time="2026-02-26T02:34:54+07:00" level=debug msg="completed keyexchange" Feb 26 02:34:54 volumio go-librespot[1653422]: time="2026-02-26T02:34:54+07:00" level=debug msg="completed challenge" Feb 26 02:34:54 volumio go-librespot[1653422]: time="2026-02-26T02:34:54+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:34:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:34:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:34:55 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:34:56 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:34:56 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:34:56 volumio volumio[1652622]: info: camilladsp respawn in 400 ms (attempt 3/10) Feb 26 02:34:56 volumio volumio[1652622]: info: Listing playlists Feb 26 02:34:56 volumio volumio[1652622]: info: Listing playlists Feb 26 02:34:56 volumio volumio[1652622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 26 02:34:56 volumio volumio[1652622]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 7 Feb 26 02:34:56 volumio volumio[1652622]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 26 02:34:56 volumio volumio-remote-updater[666]: [2026-02-26 02:34:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1772048093 101 Feb 26 02:34:56 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:34:56 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:34:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Feb 26 02:34:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:34:58 volumio go-librespot[1653443]: go-librespot daemon starting... Feb 26 02:34:58 volumio go-librespot[1653447]: time="2026-02-26T02:34:58+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:34:58 volumio go-librespot[1653447]: time="2026-02-26T02:34:58+07:00" level=debug msg="app state loaded" Feb 26 02:34:58 volumio go-librespot[1653447]: time="2026-02-26T02:34:58+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:34:59 volumio go-librespot[1653447]: time="2026-02-26T02:34:59+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 02:34:59 volumio go-librespot[1653447]: time="2026-02-26T02:34:59+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Feb 26 02:34:59 volumio go-librespot[1653447]: time="2026-02-26T02:34:59+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Feb 26 02:34:59 volumio go-librespot[1653447]: time="2026-02-26T02:34:59+07:00" level=info msg="zeroconf server listening on port 36311" Feb 26 02:34:59 volumio go-librespot[1653447]: time="2026-02-26T02:34:59+07:00" level=debug msg="obtained new client token: AACOXWZbyYwvZ2xbq6fYEtvrRSPEIlHpH2qaDlnxzLWcU7CnTnomme9MfoA7MYiRPSuGeIEjUiiNam3fzqJkryP/d4ufF090efCkTNOhk0V6H0vw7iTt+Q+QCTZ8dASsENWGxe4xusTkdAOQdUrE8c7tCJBEBg+KUWh5sycxHXXh+uKO0E6V42OcGV8c+hmbppI3R8aASH4/0R6C5fuCYpVJV/UB8+IvzkJ2YBCLnezToFZQBB7WJQ+Crfk=" Feb 26 02:35:00 volumio go-librespot[1653447]: time="2026-02-26T02:35:00+07:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Feb 26 02:35:00 volumio go-librespot[1653447]: time="2026-02-26T02:35:00+07:00" level=debug msg="connected to ap-gew4.spotify.com:443" Feb 26 02:35:00 volumio go-librespot[1653447]: time="2026-02-26T02:35:00+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:00 volumio go-librespot[1653447]: time="2026-02-26T02:35:00+07:00" level=debug msg="completed challenge" Feb 26 02:35:00 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:35:00 volumio go-librespot[1653447]: time="2026-02-26T02:35:00+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:03 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:03 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:03 volumio volumio[1652622]: info: camilladsp respawn in 800 ms (attempt 4/10) Feb 26 02:35:03 volumio volumio[1652622]: info: MyVolumio login type: Token Feb 26 02:35:03 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:35:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Feb 26 02:35:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:05 volumio go-librespot[1653477]: go-librespot daemon starting... Feb 26 02:35:05 volumio go-librespot[1653478]: time="2026-02-26T02:35:05+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:05 volumio go-librespot[1653478]: time="2026-02-26T02:35:05+07:00" level=debug msg="app state loaded" Feb 26 02:35:05 volumio go-librespot[1653478]: time="2026-02-26T02:35:05+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:06 volumio go-librespot[1653478]: time="2026-02-26T02:35:06+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:06 volumio go-librespot[1653478]: time="2026-02-26T02:35:06+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:06 volumio go-librespot[1653478]: time="2026-02-26T02:35:06+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:06 volumio go-librespot[1653478]: time="2026-02-26T02:35:06+07:00" level=info msg="zeroconf server listening on port 43061" Feb 26 02:35:07 volumio go-librespot[1653478]: time="2026-02-26T02:35:07+07:00" level=debug msg="obtained new client token: AADJuPAW4T9+FLg4BKwpqCA5RVTNxG5g1wj1pF39e8TIMylPV6NlxyqIg4Jx/7A60hHOU5NqJbwlWsjI+s9++xxfH2nbHREa4UpLUmoQyw73qdtWZNLg7/P71grZUSmT7486vVR2YFoWyNhgzxh316gpKGOlfeImNd4q8x63R/onqF6aI7E5YWGQpTakQFZIgtPn7CTsWp6m8sUggAOLuxS5/QP7U11k8r0UhAWObRAmuRBphEtMw4Zy9jo=" Feb 26 02:35:07 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:07 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:07 volumio go-librespot[1653478]: time="2026-02-26T02:35:07+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:07 volumio go-librespot[1653478]: time="2026-02-26T02:35:07+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:07 volumio go-librespot[1653478]: time="2026-02-26T02:35:07+07:00" level=debug msg="completed challenge" Feb 26 02:35:07 volumio go-librespot[1653478]: time="2026-02-26T02:35:07+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:08 volumio systemd[1]: mpd.service: start operation timed out. Terminating. Feb 26 02:35:08 volumio systemd[1]: mpd.service: Failed with result 'timeout'. Feb 26 02:35:08 volumio systemd[1]: Failed to start mpd.service - Music Player Daemon. Feb 26 02:35:08 volumio systemd[1]: mpd.service: Consumed 15.163s CPU time. Feb 26 02:35:08 volumio sudo[1653081]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:08 volumio sudo[1652809]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:08 volumio sudo[1652787]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:09 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:09 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:09 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:35:10 volumio volumio[1652622]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 26 02:35:10 volumio volumio[1652622]: Job for mpd.service failed because a timeout was exceeded. Feb 26 02:35:10 volumio volumio[1652622]: See "systemctl status mpd.service" and "journalctl -xeu mpd.service" for details. Feb 26 02:35:10 volumio volumio[1652622]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 26 02:35:10 volumio volumio[1652622]: Job for mpd.service failed because a timeout was exceeded. Feb 26 02:35:10 volumio volumio[1652622]: See "systemctl status mpd.service" and "journalctl -xeu mpd.service" for details. Feb 26 02:35:10 volumio volumio[1652622]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Feb 26 02:35:10 volumio volumio[1652622]: Job for mpd.service failed because a timeout was exceeded. Feb 26 02:35:10 volumio volumio[1652622]: See "systemctl status mpd.service" and "journalctl -xeu mpd.service" for details. Feb 26 02:35:10 volumio volumio[1652622]: info: camilladsp respawn in 1600 ms (attempt 5/10) Feb 26 02:35:10 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 26 02:35:10 volumio volumio[1652622]: info: Listing playlists Feb 26 02:35:10 volumio volumio[1652622]: info: Listing playlists Feb 26 02:35:10 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:35:10 volumio sudo[1653510]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 02:35:10 volumio sudo[1653510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 26 02:35:10 volumio sudo[1653510]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Feb 26 02:35:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:11 volumio go-librespot[1653514]: go-librespot daemon starting... Feb 26 02:35:11 volumio go-librespot[1653515]: time="2026-02-26T02:35:11+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:11 volumio go-librespot[1653515]: time="2026-02-26T02:35:11+07:00" level=debug msg="app state loaded" Feb 26 02:35:11 volumio go-librespot[1653515]: time="2026-02-26T02:35:11+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:12+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:12+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:12+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:12+07:00" level=info msg="zeroconf server listening on port 33323" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:13+07:00" level=debug msg="obtained new client token: AAA3pDrfIklF3ahc99fKlA6nnHRJrUqLanIKdNrn6pOxzhGoT/63qjjwmzOtwYPN4D496au7Ccixl+MN0rNPpecEtrDfAAomn5vH5flrSQNd/GwgwxLTJNgk58XnPRoL7oBSU8quOTN3dpRwQn3mnDFZIS1Y798s3vsOuGJHVtheM+ZiJThY9NOZ5EcceqA0M6778ah7hFqSo8sQfqPZKXuXwuP4077p53s1s67sP8k7u8RqmTxPbRm7" Feb 26 02:35:13 volumio volumio[1652622]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:13+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:13+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:13+07:00" level=debug msg="completed challenge" Feb 26 02:35:13 volumio go-librespot[1653515]: time="2026-02-26T02:35:13+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:15 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:35:16 volumio volumio[1652622]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:35:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Feb 26 02:35:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:17 volumio go-librespot[1653533]: go-librespot daemon starting... Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=debug msg="app state loaded" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=info msg="zeroconf server listening on port 34721" Feb 26 02:35:18 volumio go-librespot[1653534]: time="2026-02-26T02:35:18+07:00" level=debug msg="obtained new client token: AADmktJWWhZaMcuDQbC6+JeBcqYvsHdlBHBxptMRFJXO5s3k1Fd4C0k4mpTGqrrsbtQr6iOxfIsNAHdA1vKTdTrehiqHhflbMC8xEOMmB28UZhgDuhBmYdfpNDZOfBlYraLDne1HNiXPvVA+E3qZRPCAieoeutEPBb3HqC6E/krG9PdM9iSMCSg7GhPDLm+SY1arsLiqT/N+0NBm7PwSj2kWdLuwUDHkf7nDQ7WJja/ylhO1eHjHVbK3b8Q=" Feb 26 02:35:19 volumio go-librespot[1653534]: time="2026-02-26T02:35:19+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:19 volumio volumio[1652622]: info: camilladsp respawn in 3200 ms (attempt 6/10) Feb 26 02:35:19 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:19 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:19 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:35:20 volumio go-librespot[1653534]: time="2026-02-26T02:35:20+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:20 volumio go-librespot[1653534]: time="2026-02-26T02:35:20+07:00" level=debug msg="completed challenge" Feb 26 02:35:20 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:20 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:20 volumio go-librespot[1653534]: time="2026-02-26T02:35:20+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:20 volumio go-librespot[1653534]: time="2026-02-26T02:35:20+07:00" level=debug msg="new websocket client" Feb 26 02:35:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:21 volumio volumio[1652622]: info: Connection to go-librespot Websocket established Feb 26 02:35:23 volumio volumio[1652622]: info: Connection to go-librespot Websocket closed Feb 26 02:35:23 volumio volumio[1652622]: info: CoreCommandRouter::volumioGetState Feb 26 02:35:23 volumio volumio[1652622]: info: CorePlayQueue::getTrack 0 Feb 26 02:35:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Feb 26 02:35:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:24 volumio volumio[1652622]: info: MyVolumio token set successfully Feb 26 02:35:24 volumio volumio[1652622]: info: MYVOLUMIO: Adding device Feb 26 02:35:24 volumio volumio[1652622]: info: MYVOLUMIO: Evaluating Server Feb 26 02:35:24 volumio go-librespot[1653562]: go-librespot daemon starting... Feb 26 02:35:24 volumio volumio[1652622]: info: Listing playlists Feb 26 02:35:24 volumio volumio[1652622]: info: Listing playlists Feb 26 02:35:24 volumio go-librespot[1653563]: time="2026-02-26T02:35:24+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:24 volumio go-librespot[1653563]: time="2026-02-26T02:35:24+07:00" level=debug msg="app state loaded" Feb 26 02:35:24 volumio go-librespot[1653563]: time="2026-02-26T02:35:24+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=info msg="zeroconf server listening on port 39659" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=debug msg="obtained new client token: AAARt7CNSBD6B84zplxNnI961P/6WVMhge4aovw9S0rZ4Sqy4dGVCf5XKNnrDKFZA/C/PboiIACEydjrNyeu1AdQi9HiHPc8mKrKrZqTvJX/AFyYmoSI5dmsu5/rjxGr30k3w3Dkl+JwTG19OTRh01vTJr91thkfw1ZGXR3EliOQ1Gh/5gq0JUV1kkoSX9q8emFR/fvfOhXOJ/NWd+oYyWj7jKHcXGV9Vv31LVALl/rnzI1Xhv6p2RW5SqA=" Feb 26 02:35:25 volumio go-librespot[1653563]: time="2026-02-26T02:35:25+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:26 volumio go-librespot[1653563]: time="2026-02-26T02:35:26+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:26 volumio go-librespot[1653563]: time="2026-02-26T02:35:26+07:00" level=debug msg="completed challenge" Feb 26 02:35:26 volumio go-librespot[1653563]: time="2026-02-26T02:35:26+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:28 volumio volumio[1652622]: info: Getting Spotify volume Feb 26 02:35:28 volumio volumio[1652622]: info: Initializing connection to go-librespot Websocket Feb 26 02:35:28 volumio volumio[1652622]: info: MyVolumio status changed Feb 26 02:35:28 volumio volumio[1652622]: info: Streaming services startup Feb 26 02:35:28 volumio volumio[1652622]: info: Starting Streaming Daemon Feb 26 02:35:28 volumio volumio[1652622]: info: Removing browser output: myVolumio user plan is not superstar Feb 26 02:35:28 volumio volumio[1652622]: info: Removing audio output: Feb 26 02:35:28 volumio volumio[1652622]: info: Stoppping Tunnel 1 Feb 26 02:35:29 volumio sudo[1653601]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 26 02:35:29 volumio sudo[1653603]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 26 02:35:29 volumio sudo[1653603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:35:29 volumio sudo[1653601]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 26 02:35:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Feb 26 02:35:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:29 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:29 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 26 02:35:30 volumio go-librespot[1653607]: go-librespot daemon starting... Feb 26 02:35:30 volumio sudo[1653601]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:30 volumio sudo[1653603]: pam_unix(sudo:session): session closed for user root Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=debug msg="app state loaded" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:30 volumio go-librespot[1653608]: time="2026-02-26T02:35:30+07:00" level=info msg="zeroconf server listening on port 36349" Feb 26 02:35:31 volumio go-librespot[1653608]: time="2026-02-26T02:35:31+07:00" level=debug msg="obtained new client token: AAD7F5OYOSswpstWRgyRs8ae9GKjdUeiL+DYl/b3+UpQy55QKbhtBp6umAXuyoJ3jiZyBusCqVSNbrvIe14XB5clpE75I1QH7eB3YZaG0Pu8SMS9jyNbE4lN9W52QF5GK7WLECMhcVRPIZo8S/tItEkjwxEz2n3/+oh62NNEGDnpWZgExOHvel0ju94O6qTAEmZcTT1AqNv2N1sH4KhgXtOa8XqCZtJ46/a/g8y5L0wO3FDxzsasjioV" Feb 26 02:35:31 volumio go-librespot[1653608]: time="2026-02-26T02:35:31+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:31 volumio go-librespot[1653608]: time="2026-02-26T02:35:31+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:31 volumio go-librespot[1653608]: time="2026-02-26T02:35:31+07:00" level=debug msg="completed challenge" Feb 26 02:35:31 volumio go-librespot[1653608]: time="2026-02-26T02:35:31+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:32 volumio volumio[1652622]: info: Setting Geolocation for MyVolumio to as1 Feb 26 02:35:32 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:35:32 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:35:32 volumio volumio[1652622]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 02:35:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Feb 26 02:35:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:35 volumio volumio[1652622]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:35:35 volumio go-librespot[1653632]: go-librespot daemon starting... Feb 26 02:35:36 volumio go-librespot[1653634]: time="2026-02-26T02:35:36+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:36 volumio go-librespot[1653634]: time="2026-02-26T02:35:36+07:00" level=debug msg="app state loaded" Feb 26 02:35:36 volumio go-librespot[1653634]: time="2026-02-26T02:35:36+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:37 volumio volumio[1652622]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 02:35:37 volumio volumio[1652622]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 26 02:35:37 volumio volumio[1652622]: errno: -111, Feb 26 02:35:37 volumio volumio[1652622]: code: 'ECONNREFUSED', Feb 26 02:35:37 volumio volumio[1652622]: syscall: 'connect', Feb 26 02:35:37 volumio volumio[1652622]: address: '127.0.0.1', Feb 26 02:35:37 volumio volumio[1652622]: port: 9879, Feb 26 02:35:37 volumio volumio[1652622]: response: undefined Feb 26 02:35:37 volumio volumio[1652622]: } Feb 26 02:35:37 volumio go-librespot[1653634]: time="2026-02-26T02:35:37+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:37 volumio go-librespot[1653634]: time="2026-02-26T02:35:37+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:37 volumio go-librespot[1653634]: time="2026-02-26T02:35:37+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:37+07:00" level=info msg="zeroconf server listening on port 33777" Feb 26 02:35:38 volumio volumio[1652622]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:38+07:00" level=debug msg="obtained new client token: AACztjZ6TExLW8KsXIEBsku4uWa+FTXXVceKudMDEtv9g1wh3HIiJuvyUCL7XGVgt0LbzNahL9W1IiS1RR/ldOvGFYRPNpIec+/LyPE6pD7HneZ2pL0ls/rsH4wt5gWceOPvNUvLIK74geBrRu+9AvNTDCyAZJSbmcLrNehnhxApaotnRBu9IgKevAbY5j4al7nPQtAs+f/KcNKWb99EF98R+YtibaygNBGQkbDrju4x3IAnTRxBcKyO" Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:38+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:38+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:38+07:00" level=debug msg="completed challenge" Feb 26 02:35:38 volumio go-librespot[1653634]: time="2026-02-26T02:35:38+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Feb 26 02:35:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:42 volumio go-librespot[1653670]: go-librespot daemon starting... Feb 26 02:35:42 volumio go-librespot[1653671]: time="2026-02-26T02:35:42+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:42 volumio go-librespot[1653671]: time="2026-02-26T02:35:42+07:00" level=debug msg="app state loaded" Feb 26 02:35:42 volumio go-librespot[1653671]: time="2026-02-26T02:35:42+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=info msg="zeroconf server listening on port 37467" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="obtained new client token: AACZtMCk56EONvN9+l9s11u6+rp2auW9h5qSwkOBIBf9ky/oNKMlwU/kCKpA8XLE+isNVUarUwjilTdMgdM2kHh3C8VbiSemfAjlP0T/ZquX6AfPz5RuVpcWPTTyC0C2TfbrNH/w9Hqm+IvIv1cL3xv+L6O+kL3QRKQanncGG2G10fPQ5/Kp4QlLUeeW0wuCwITOmGR+Vlc1Jlqh55urG+VfoRgc2FyIIHZLtK6yzom8KmyiknqUT5R+Yeg=" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:44 volumio go-librespot[1653671]: time="2026-02-26T02:35:44+07:00" level=debug msg="completed challenge" Feb 26 02:35:45 volumio go-librespot[1653671]: time="2026-02-26T02:35:45+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Feb 26 02:35:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:49 volumio go-librespot[1653683]: go-librespot daemon starting... Feb 26 02:35:49 volumio go-librespot[1653684]: time="2026-02-26T02:35:49+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:49 volumio go-librespot[1653684]: time="2026-02-26T02:35:49+07:00" level=debug msg="app state loaded" Feb 26 02:35:49 volumio go-librespot[1653684]: time="2026-02-26T02:35:49+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=info msg="zeroconf server listening on port 40741" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="obtained new client token: AACjB0+O6XecU5PRVHaCRy+Z4AW9TTNVGb8EJ3WfTKTzADA0YiPOE0g6/7rCLBVvX4noS4vspAol6Sw67CPJ1V6cUUKv+IOSmffiAPUNX84Lgkiso/1/qvyl/3PMzUSTAeRcMstJbYzPpj8LRPslPc4Dgi57BPP1dWWSnut4J5pt766rOJ7tVWsaDnCgjRUTnBSJz3HqcGmJ2gV9sFjZUYALUPuMmClg+yrvE70K4vLkCfwreX87JZBq" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:50 volumio go-librespot[1653684]: time="2026-02-26T02:35:50+07:00" level=debug msg="completed challenge" Feb 26 02:35:51 volumio go-librespot[1653684]: time="2026-02-26T02:35:51+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Feb 26 02:35:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 02:35:54 volumio go-librespot[1653708]: go-librespot daemon starting... Feb 26 02:35:54 volumio go-librespot[1653709]: time="2026-02-26T02:35:54+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 02:35:54 volumio go-librespot[1653709]: time="2026-02-26T02:35:54+07:00" level=debug msg="app state loaded" Feb 26 02:35:54 volumio go-librespot[1653709]: time="2026-02-26T02:35:54+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=info msg="zeroconf server listening on port 38919" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=debug msg="obtained new client token: AADskMpmgU/ml6IUZxXVNCN3jOYr5E+jW+3IK2tWTcwoC+VI40oCmmujlsM9bvJXJG+chf4BE/plFMG9fRKLKoiEXViJ/8LaGbe7wW8yAiuP+TALiwOPRpJwx5YjeXpGfwqMwWbrENk1xK1k3bOpxE6JPlbXUZl5HoJVubYv06TCLADxQsXrz9pXUNIxPFmeCsmA+/+X9Rz00isqlUCshQ/FSGLsR7e44CJnmbE9a3eAh0dyDCVT/FydDU4=" Feb 26 02:35:55 volumio go-librespot[1653709]: time="2026-02-26T02:35:55+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 02:35:56 volumio go-librespot[1653709]: time="2026-02-26T02:35:56+07:00" level=debug msg="completed keyexchange" Feb 26 02:35:56 volumio go-librespot[1653709]: time="2026-02-26T02:35:56+07:00" level=debug msg="completed challenge" Feb 26 02:35:56 volumio go-librespot[1653709]: time="2026-02-26T02:35:56+07:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Feb 26 02:35:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 02:35:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 02:35:57 volumio sudo[1653717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 02:34' Feb 26 02:35:57 volumio sudo[1653717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"