Feb 26 01:58:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 50. Feb 26 01:58:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:04 volumio systemd[1]: go-librespot-daemon.service: Consumed 1.089s CPU time. Feb 26 01:58:04 volumio volumio-remote-updater[666]: [2026-02-26 01:58:04] [connect] Successful connection Feb 26 01:58:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:07 volumio go-librespot[1642069]: go-librespot daemon starting... Feb 26 01:58:08 volumio go-librespot[1642081]: time="2026-02-26T01:58:08+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:08 volumio go-librespot[1642081]: time="2026-02-26T01:58:08+07:00" level=debug msg="app state loaded" Feb 26 01:58:11 volumio go-librespot[1642081]: time="2026-02-26T01:58:09+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:15 volumio nmbd[979]: [2026/02/26 01:58:15.766430, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 26 01:58:15 volumio nmbd[979]: query_name_response: Multiple (2) responses received for a query on subnet 10.10.9.65 for name WORKGROUP<1d>. Feb 26 01:58:15 volumio nmbd[979]: This response was from IP 10.10.9.5, reporting an IP address of 10.10.9.5. Feb 26 01:58:20 volumio go-librespot[1642081]: time="2026-02-26T01:58:20+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": net/http: TLS handshake timeout" Feb 26 01:58:20 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 26 01:58:21 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 26 01:58:21 volumio volumio-remote-updater[666]: [2026-02-26 01:58:21] [connect] Successful connection Feb 26 01:58:21 volumio systemd[1]: setdatetime-helper.service: Consumed 1min 5.852s CPU time. Feb 26 01:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:58:23 volumio systemd[1]: go-librespot-daemon.service: Consumed 1.126s CPU time. Feb 26 01:58:23 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 26 01:58:24 volumio volumio5-onboarding[2061]: time=2026-02-26T01:58:23.018+07:00 level=ERROR msg="failed to broadcast Ethernet info" component=state error="failed to get ethernet info: failed to get routes for interface eth0: resource temporarily unavailable" Feb 26 01:58:24 volumio volumio5-onboarding[2061]: time=2026-02-26T01:58:24.197+07:00 level=ERROR msg="failed reading message" component=volumio/socket error="websocket: close 1000 (normal)" Feb 26 01:58:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 51. Feb 26 01:58:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:27 volumio systemd[1]: go-librespot-daemon.service: Consumed 1.126s CPU time. Feb 26 01:58:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:28 volumio go-librespot[1642139]: go-librespot daemon starting... Feb 26 01:58:28 volumio go-librespot[1642141]: time="2026-02-26T01:58:28+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:29 volumio go-librespot[1642141]: time="2026-02-26T01:58:28+07:00" level=debug msg="app state loaded" Feb 26 01:58:29 volumio go-librespot[1642141]: time="2026-02-26T01:58:29+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:31 volumio go-librespot[1642141]: time="2026-02-26T01:58:31+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 01:58:31 volumio go-librespot[1642141]: time="2026-02-26T01:58:31+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 01:58:31 volumio go-librespot[1642141]: time="2026-02-26T01:58:31+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 01:58:31 volumio go-librespot[1642141]: time="2026-02-26T01:58:31+07:00" level=info msg="zeroconf server listening on port 43451" Feb 26 01:58:31 volumio go-librespot[1642141]: time="2026-02-26T01:58:31+07:00" level=debug msg="obtained new client token: AAA7qGHWNX4hcLjoXoA0Obg+jRrxpZk0PpPnw2EDZ8E3ceiPOdWoq0gYDhexb8q3LlgFZQtISR/AuR2Eykr76sbVMV6RbAT8M49AxO9YW6I5FNlbLcOHvcKRgo1jMh4Q5RglLS4zdkME2hjvdlasgDYY30LPPz4SDCVeaMWd+/qdkHcvz5XiyUCRnr7Jku+8pztomxGLiyQiSfJXDO+dbPRtE9R5QB3h+4noZ2aT5sOfCH4KL1WDbM4AlsY=" Feb 26 01:58:32 volumio go-librespot[1642141]: time="2026-02-26T01:58:32+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:58:32 volumio go-librespot[1642141]: time="2026-02-26T01:58:32+07:00" level=debug msg="completed keyexchange" Feb 26 01:58:32 volumio go-librespot[1642141]: time="2026-02-26T01:58:32+07:00" level=debug msg="completed challenge" Feb 26 01:58:32 volumio go-librespot[1642141]: time="2026-02-26T01:58:32+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 01:58:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:58:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:58:36 volumio volumio-remote-updater[666]: [2026-02-26 01:58:36] [connect] Successful connection Feb 26 01:58:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 52. Feb 26 01:58:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:38 volumio go-librespot[1642169]: go-librespot daemon starting... Feb 26 01:58:38 volumio go-librespot[1642171]: time="2026-02-26T01:58:38+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:38 volumio go-librespot[1642171]: time="2026-02-26T01:58:38+07:00" level=debug msg="app state loaded" Feb 26 01:58:38 volumio go-librespot[1642171]: time="2026-02-26T01:58:38+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:41 volumio go-librespot[1642171]: time="2026-02-26T01:58: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-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Feb 26 01:58:41 volumio go-librespot[1642171]: time="2026-02-26T01:58:41+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 01:58:41 volumio go-librespot[1642171]: time="2026-02-26T01:58:41+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 01:58:41 volumio go-librespot[1642171]: time="2026-02-26T01:58:41+07:00" level=info msg="zeroconf server listening on port 45257" Feb 26 01:58:41 volumio go-librespot[1642171]: time="2026-02-26T01:58:41+07:00" level=debug msg="obtained new client token: AADK5MkINKWZP/J4uvTa0Kct+3CbRK62IC1/DFqAryONjhc+degMWTIDm0jpY/3K4hPgH3H49lRxxLuf/UO758rtzUIYaPhi7FWqukFxfHkIrzFLG4lBLDNGMyC3HCTlRzY385W6koCpICF1eYer+g1v77L2nFeU01xs/5ik8j6ImnjiF8h173+tA+Smdp8xuJxo5judLjJv3XNZ3FJC4aohUEwe04agXTkmRTduaStvpoA3Zm/ai+eEI/c=" Feb 26 01:58:42 volumio go-librespot[1642171]: time="2026-02-26T01:58:42+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:58:42 volumio go-librespot[1642171]: time="2026-02-26T01:58:42+07:00" level=debug msg="completed keyexchange" Feb 26 01:58:42 volumio go-librespot[1642171]: time="2026-02-26T01:58:42+07:00" level=debug msg="completed challenge" Feb 26 01:58:42 volumio go-librespot[1642171]: time="2026-02-26T01:58: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 01:58:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:58:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:58:44 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 26 01:58:44 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 26 01:58:44 volumio volumio5-onboarding[2061]: time=2026-02-26T01:58:44.086+07:00 level=ERROR msg="failed to update discovery on Ethernet info change" error="failed to get system info: could not get system info: context deadline exceeded" Feb 26 01:58:44 volumio systemd[1]: setdatetime-helper.service: Consumed 2.189s CPU time. Feb 26 01:58:44 volumio volumio5-onboarding[2061]: time=2026-02-26T01:58:43.820+07:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp: lookup localhost: i/o timeout" Feb 26 01:58:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 53. Feb 26 01:58:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:46 volumio go-librespot[1642205]: go-librespot daemon starting... Feb 26 01:58:46 volumio go-librespot[1642207]: time="2026-02-26T01:58:46+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:46 volumio go-librespot[1642207]: time="2026-02-26T01:58:46+07:00" level=debug msg="app state loaded" Feb 26 01:58:46 volumio go-librespot[1642207]: time="2026-02-26T01:58:46+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+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 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+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 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+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 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+07:00" level=info msg="zeroconf server listening on port 34137" Feb 26 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+07:00" level=debug msg="obtained new client token: AAAmaah3SkuBCPhmtR7068ZSaATHID9HCgkIaWZ7SLG+myv+jv8/KLTRiJxnAqyFfCFR2wklEfmEFiJ/tRBC5PA0vpT37aAQBSHxx9C/V57l2SJDKHcw3Gs8SiIxZwmZx2lO/iSIR0kOHFnwv0G0jv+QxeSc8TR6FC/g/EimgCiz8spjln/8jOuJlweU7hokyESDTtxwdvHNCXdzyD6xdGzDAbmJTdkdRwfXNSAuJzupiEAkR9bd/LDyr+U=" Feb 26 01:58:47 volumio go-librespot[1642207]: time="2026-02-26T01:58:47+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:58:48 volumio go-librespot[1642207]: time="2026-02-26T01:58:48+07:00" level=debug msg="completed keyexchange" Feb 26 01:58:48 volumio go-librespot[1642207]: time="2026-02-26T01:58:48+07:00" level=debug msg="completed challenge" Feb 26 01:58:48 volumio go-librespot[1642207]: time="2026-02-26T01:58:48+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 01:58:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:58:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:58:51 volumio volumio-remote-updater[666]: [2026-02-26 01:58:51] [connect] Successful connection Feb 26 01:58:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 54. Feb 26 01:58:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:52 volumio volumio[1639412]: info: Remote SSH Stopped Feb 26 01:58:52 volumio go-librespot[1642217]: go-librespot daemon starting... Feb 26 01:58:52 volumio volumio[1639412]: error: Cannot start Volumio Streaming Daemon Feb 26 01:58:52 volumio volumio[1639412]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 26 01:58:52 volumio volumio[1639412]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 26 01:58:52 volumio go-librespot[1642219]: time="2026-02-26T01:58:52+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:52 volumio go-librespot[1642219]: time="2026-02-26T01:58:52+07:00" level=debug msg="app state loaded" Feb 26 01:58:53 volumio go-librespot[1642219]: time="2026-02-26T01:58:53+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:53 volumio go-librespot[1642219]: time="2026-02-26T01:58: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-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 01:58:53 volumio go-librespot[1642219]: time="2026-02-26T01:58:53+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 01:58:53 volumio go-librespot[1642219]: time="2026-02-26T01:58:53+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 01:58:53 volumio go-librespot[1642219]: time="2026-02-26T01:58:53+07:00" level=info msg="zeroconf server listening on port 41569" Feb 26 01:58:54 volumio go-librespot[1642219]: time="2026-02-26T01:58:54+07:00" level=debug msg="obtained new client token: AACB99/4rs9MwdgMfOGL9XzmgLR8Ccmsq1bRre+lXfpzRqtEcktyZ4dK14+BRuouvhBLy7Pd9lRV4BMOmjl5Jho78sq1sugceMrGohWqhLO8SNuZwQGKRP/PBg6qLd/Zlwozy3ZQu85PmS/+P4frKnYv1Lld0bdvw9W1VhgHyzdqbC8OcddVUY3xRzAlcMy/rVmfX55r5kN7IxkLP318KAqWMtVQzgiCj7mPjUM4usNC2ib511UG2H7S" Feb 26 01:58:54 volumio go-librespot[1642219]: time="2026-02-26T01:58:54+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:58:54 volumio go-librespot[1642219]: time="2026-02-26T01:58:54+07:00" level=debug msg="completed keyexchange" Feb 26 01:58:54 volumio go-librespot[1642219]: time="2026-02-26T01:58:54+07:00" level=debug msg="completed challenge" Feb 26 01:58:54 volumio go-librespot[1642219]: time="2026-02-26T01:58: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 01:58:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:58:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:58:55 volumio volumio[1639412]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 01:58:55 volumio volumio[1639412]: info: camilladsp respawn in 100 ms (attempt 1/10) Feb 26 01:58:55 volumio volumio5-onboarding[2061]: time=2026-02-26T01:58:55.901+07:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:60796->127.0.0.1:3000: i/o timeout" Feb 26 01:58:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 55. Feb 26 01:58:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:58:58 volumio go-librespot[1642251]: go-librespot daemon starting... Feb 26 01:58:58 volumio go-librespot[1642252]: time="2026-02-26T01:58:58+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:58:58 volumio go-librespot[1642252]: time="2026-02-26T01:58:58+07:00" level=debug msg="app state loaded" Feb 26 01:58:58 volumio go-librespot[1642252]: time="2026-02-26T01:58:58+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58: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-gae2.spotify.com:80]" Feb 26 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58:59+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 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58:59+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 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58:59+07:00" level=info msg="zeroconf server listening on port 45561" Feb 26 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58:59+07:00" level=debug msg="obtained new client token: AABFO6C43S8PfxIZx+jnsaXIXDHA+IEnG6eQvSYpwKawnIeZ6go2t1ylECZh3+bR9MFWs4F7GNoI1kFtBfsDn3KXq7LA0nI2Oa9ybqL2PdN9nVF8nOIdgd6ffGvOnYFXv9a/hWHABmLQrsTP+BBI1JSyLaBIZbmkJlx5hJaIWdGtqkFnVuhyboWty/jlrLqHPePnXwVGtzN1Ex1E+NyRkql7DdGzbb+cwUbkmK2dLvDJdQk+jKkRaPJT6GU=" Feb 26 01:58:59 volumio go-librespot[1642252]: time="2026-02-26T01:58:59+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:00 volumio go-librespot[1642252]: time="2026-02-26T01:59:00+07:00" level=debug msg="completed keyexchange" Feb 26 01:59:00 volumio go-librespot[1642252]: time="2026-02-26T01:59:00+07:00" level=debug msg="completed challenge" Feb 26 01:59:00 volumio go-librespot[1642252]: time="2026-02-26T01:59: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 01:59:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:59:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:59:01 volumio volumio[1639412]: info: camilladsp respawn in 200 ms (attempt 2/10) Feb 26 01:59:01 volumio volumio[1639412]: info: Initializing connection to go-librespot Websocket Feb 26 01:59:02 volumio volumio[1639412]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 01:59:02 volumio volumio[1639412]: info: [MQTT] Connected to MQTT broker Feb 26 01:59:02 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:02 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 56. Feb 26 01:59:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:04 volumio go-librespot[1642263]: go-librespot daemon starting... Feb 26 01:59:04 volumio go-librespot[1642271]: time="2026-02-26T01:59:04+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:59:04 volumio go-librespot[1642271]: time="2026-02-26T01:59:04+07:00" level=debug msg="app state loaded" Feb 26 01:59:04 volumio go-librespot[1642271]: time="2026-02-26T01:59:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59: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-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+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 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+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 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+07:00" level=info msg="zeroconf server listening on port 39049" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+07:00" level=debug msg="obtained new client token: AACbUuZTdIAeyh++Ean2krZeoHZhwi+s0K1cyBxeLjhMiwfNY6I+SsaZbHSwHas58vNczBeItYEeuKolaAquDl4YOpqW371A5EftinqtYmxSM6UzN4WAIzbIhFkHlWrH5OJfNM5nm0adcALglzwWDToObECrzP5NI1vvmh+uIBs7oLa5KI6SbSu/7bpse4MeXGW4i646j1OBOuuk7CgA4mkmVWrBhXVghc1xH+9rqfNOs2/oUvT4A5Q5uN8=" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+07:00" level=debug msg="completed keyexchange" Feb 26 01:59:05 volumio go-librespot[1642271]: time="2026-02-26T01:59:05+07:00" level=debug msg="completed challenge" Feb 26 01:59:06 volumio volumio[1639412]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 01:59:06 volumio go-librespot[1642271]: time="2026-02-26T01:59:06+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 01:59:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:59:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:59:06 volumio volumio[1639412]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 01:59:06 volumio volumio[1639412]: info: camilladsp respawn in 400 ms (attempt 3/10) Feb 26 01:59:07 volumio volumio-remote-updater[666]: [2026-02-26 01:59:06] [connect] Successful connection Feb 26 01:59:07 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:07 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:07 volumio volumio5-onboarding[2061]: time=2026-02-26T01:59:07.898+07:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:34016->127.0.0.1:3000: i/o timeout" Feb 26 01:59:08 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:08 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:08 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:08 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:08 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:08 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:08 volumio volumio[1639412]: info: Listing playlists Feb 26 01:59:08 volumio volumio[1639412]: info: Listing playlists Feb 26 01:59:08 volumio volumio[1639412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 26 01:59:08 volumio volumio[1639412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 26 01:59:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 57. Feb 26 01:59:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:10 volumio go-librespot[1642304]: go-librespot daemon starting... Feb 26 01:59:10 volumio go-librespot[1642305]: time="2026-02-26T01:59:10+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:59:10 volumio go-librespot[1642305]: time="2026-02-26T01:59:10+07:00" level=debug msg="app state loaded" Feb 26 01:59:10 volumio go-librespot[1642305]: time="2026-02-26T01:59:10+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+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 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+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 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+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 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+07:00" level=info msg="zeroconf server listening on port 38987" Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+07:00" level=debug msg="obtained new client token: AAC0klLxWRsczSkF4ZFUri3eiQCqtxXJc3sSpq2oM2KLAqiN8EkpJO9Wt0mAubIUBBYoUpGIV963kkiHNFq76xeN0faXFg2u6kte2Uu0imr6caXUcC0kGc+8adsJ0kHMDGaYAy3oH9Gcy1myoqiEZDhB5Mj4Cl9Dz8cwFSHFB8dbxl5+1xCoa2TPmXCi/0jvHgK0W2Cax5qPTzIRE8TkNRkbidHJZzhHd3N1cyIiBq8nu6JXutbzkbZtduc=" Feb 26 01:59:11 volumio volumio[1639412]: info: Initializing connection to go-librespot Websocket Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+07:00" level=debug msg="completed keyexchange" Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59:11+07:00" level=debug msg="completed challenge" Feb 26 01:59:11 volumio go-librespot[1642305]: time="2026-02-26T01:59: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 01:59:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:59:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:59:12 volumio volumio[1639412]: info: MYVOLUMIO: Adding device Feb 26 01:59:12 volumio volumio[1639412]: info: MYVOLUMIO: Evaluating Server Feb 26 01:59:13 volumio volumio[1639412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 26 01:59:13 volumio volumio[1639412]: info: camilladsp respawn in 800 ms (attempt 4/10) Feb 26 01:59:13 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:13 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:13 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:13 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:13 volumio volumio[1639412]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 26 01:59:14 volumio volumio[1639412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Feb 26 01:59:14 volumio volumio[1639412]: info: Setting Geolocation for MyVolumio to as1 Feb 26 01:59:14 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:14 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:14 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:14 volumio volumio[1639412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Feb 26 01:59:15 volumio volumio[1639412]: info: Updating MyVolumio device info Feb 26 01:59:15 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:15 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:15 volumio volumio[1639412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 01:59:15 volumio volumio[1639412]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 26 01:59:15 volumio volumio[1639412]: info: CoreCommandRouter::volumioGetState Feb 26 01:59:15 volumio volumio[1639412]: info: CorePlayQueue::getTrack 0 Feb 26 01:59:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 58. Feb 26 01:59:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:15 volumio volumio[1639412]: info: camilladsp respawn in 1600 ms (attempt 5/10) Feb 26 01:59:15 volumio go-librespot[1642355]: go-librespot daemon starting... Feb 26 01:59:15 volumio go-librespot[1642356]: time="2026-02-26T01:59:15+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:59:15 volumio go-librespot[1642356]: time="2026-02-26T01:59:15+07:00" level=debug msg="app state loaded" Feb 26 01:59:15 volumio go-librespot[1642356]: time="2026-02-26T01:59:15+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:59:16 volumio volumio[1639412]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 26 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+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 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+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 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+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 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+07:00" level=info msg="zeroconf server listening on port 46541" Feb 26 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+07:00" level=debug msg="obtained new client token: AABUmbnFw/otKSwb7CZuTz8DyeJZ5vSRbhTGTkRBrKjRM1e59AbXzIEwmBqvLtvx7bm9YhhLOnE5f4wH8eE09/uJ2HSGiWPTW3dLp84sLhp2Rc+e8+hPo6hAjHXlVN0Qvo8nhVKj4wv5vX51UY5YypJQwPSchHlDGAdn8JCBEhKDjQtsx0PUQU1opssjqqZm04c9xESoaUfbAZiLC5GkUDvZXzZ2GVW/JpPBb8g+bvEJLhRQSfTskeIXqHA=" Feb 26 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+07:00" level=debug msg="completed keyexchange" Feb 26 01:59:16 volumio go-librespot[1642356]: time="2026-02-26T01:59:16+07:00" level=debug msg="completed challenge" Feb 26 01:59:16 volumio volumio[1639412]: info: Initializing connection to go-librespot Websocket Feb 26 01:59:17 volumio go-librespot[1642356]: time="2026-02-26T01:59:17+07:00" level=debug msg="new websocket client" Feb 26 01:59:17 volumio go-librespot[1642356]: time="2026-02-26T01:59:17+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 01:59:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:59:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:59:17 volumio volumio[1639412]: info: Connection to go-librespot Websocket established Feb 26 01:59:17 volumio volumio[1639412]: info: Connection to go-librespot Websocket closed Feb 26 01:59:18 volumio volumio[1639412]: info: camilladsp respawn in 3200 ms (attempt 6/10) Feb 26 01:59:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 59. Feb 26 01:59:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:20 volumio go-librespot[1642374]: go-librespot daemon starting... Feb 26 01:59:20 volumio go-librespot[1642375]: time="2026-02-26T01:59:20+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:59:20 volumio go-librespot[1642375]: time="2026-02-26T01:59:20+07:00" level=debug msg="app state loaded" Feb 26 01:59:20 volumio go-librespot[1642375]: time="2026-02-26T01:59:20+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:59:21 volumio volumio[1639412]: info: Getting Spotify volume Feb 26 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+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 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+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 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+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 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+07:00" level=info msg="zeroconf server listening on port 40317" Feb 26 01:59:21 volumio volumio[1639412]: info: Initializing connection to go-librespot Websocket Feb 26 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+07:00" level=debug msg="obtained new client token: AABFUoj3wGRaY3U+zY8gHw0TvwOYo1Mvfd3axs06kKsWoU+ej1yjZkHGY+H/BsQaNOjRF1quSXWrN3MsPLF5ShPrDEbspOiP/PXa1qdhs9ockqwnHWsHq4wwxCpE8f1WGt/vSvL7y538/9JAoTNr3LmSXg9a4yL6E+GYUJl+d8tDyC16ZmZHFyEykMXEkKExIHijU0XpfdU4hbMdGPV8N5vw/LSyWncxdIjFwEAcyatJeHZ+Wnjlv5ckxOE=" Feb 26 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:21 volumio go-librespot[1642375]: time="2026-02-26T01:59:21+07:00" level=debug msg="new websocket client" Feb 26 01:59:22 volumio go-librespot[1642375]: time="2026-02-26T01:59:22+07:00" level=debug msg="completed keyexchange" Feb 26 01:59:22 volumio go-librespot[1642375]: time="2026-02-26T01:59:22+07:00" level=debug msg="completed challenge" Feb 26 01:59:22 volumio volumio-remote-updater[666]: [2026-02-26 01:59:22] [connect] Successful connection Feb 26 01:59:22 volumio go-librespot[1642375]: time="2026-02-26T01:59:22+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 01:59:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 26 01:59:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 26 01:59:22 volumio volumio[1639412]: 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 01:59:23 volumio volumio[1639412]: info: Connection to go-librespot Websocket established Feb 26 01:59:23 volumio volumio[1639412]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 01:59:23 volumio volumio[1639412]: Error: socket hang up Feb 26 01:59:23 volumio volumio[1639412]: at connResetException (node:internal/errors:720:14) Feb 26 01:59:23 volumio volumio[1639412]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 26 01:59:23 volumio volumio[1639412]: at Socket.emit (node:events:526:35) Feb 26 01:59:23 volumio volumio[1639412]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 26 01:59:23 volumio volumio[1639412]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 26 01:59:23 volumio volumio[1639412]: code: 'ECONNRESET', Feb 26 01:59:23 volumio volumio[1639412]: response: undefined Feb 26 01:59:23 volumio volumio[1639412]: } Feb 26 01:59:23 volumio volumio[1639412]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 01:59:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 60. Feb 26 01:59:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 26 01:59:26 volumio go-librespot[1642419]: go-librespot daemon starting... Feb 26 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+07:00" level=info msg="running go-librespot 0.4.0" Feb 26 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+07:00" level=debug msg="app state loaded" Feb 26 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+07:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 26 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+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 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+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 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+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 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+07:00" level=info msg="zeroconf server listening on port 39547" Feb 26 01:59:26 volumio go-librespot[1642420]: time="2026-02-26T01:59:26+07:00" level=debug msg="obtained new client token: AADbJ0gIYLxUqfHyALIrxdDs+knBeWHXbzix49el87GReuuq1B0ngeDHO1joqiE1F6TeAW16z8tBjuf282qZbgXKcWYMXEuHLP1TucKQys2ck1qMZXIa78ahtQn5lh+NaqbpUL2HoqiQRG7h49LS+mF0vNqJKhjt/ETbm15zah0Mt29iRunOqoHpaoWjqV2pN9mNJSpOvFckgKcW8ObZK5Pft/m/nzILcE/HjjKrMtCBed948ZYDj0lnd0U=" Feb 26 01:59:27 volumio go-librespot[1642420]: time="2026-02-26T01:59:27+07:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 26 01:59:27 volumio sudo[1642428]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-26 01:58' Feb 26 01:59:27 volumio sudo[1642428]: 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"