Nov 03 03:45:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Nov 03 03:45:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:00 volumio go-librespot[25604]: go-librespot daemon starting... Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="app state loaded" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=info msg="zeroconf server listening on port 35129" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="obtained new client token: AAA+UZFnflUVFGyCLMbQgYzLdng6cdYSEQnWb3bhop65grtEztZIHlrDhyxcSVnSgHTheMeTfZDARQSsGuGL4cfsSzCOSE/cgUR1hsvlIlF/z1ejAHasRwpyBG6JLaDMVQ4D/gsHjTPProm0oE1WGlKv2KK5KoQ7Kzje6TABNY5/cgU7qyUQnYoT40TYprW6vTQgrStBhCayEuC9k/IPn0T44fWzYDyomOjw20S5uELRnRERsXJuL2A=" Nov 03 03:45:00 volumio go-librespot[25605]: time="2025-11-03T03:45:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:01 volumio go-librespot[25605]: time="2025-11-03T03:45:01Z" level=debug msg="completed keyexchange" Nov 03 03:45:01 volumio go-librespot[25605]: time="2025-11-03T03:45:01Z" level=debug msg="completed challenge" Nov 03 03:45:01 volumio go-librespot[25605]: time="2025-11-03T03:45:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:01 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:01 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Nov 03 03:45:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:04 volumio go-librespot[25614]: go-librespot daemon starting... Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="app state loaded" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=info msg="zeroconf server listening on port 37859" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="obtained new client token: AACDg+kkrdrekg2nuDGIiH946gPd+bnLj2Ej5yrJ7Ad6XFPrFwkmKXl223DFNn1ZS3oJ8AbUMkERU2rSvm+oSCHrpDLRkFJXkAm57SHy5gI3O5he0f6ZA67KoZ9vE10V25jwanut4w0owGzbA3DtrK9RxdF9Gd6AqTIsGBmMpSxpKHyuAhoQqv4FkVR/tV7+tuNzC2nzQiiQuhmG1e3c+0VG/RtV/Q2ZKSpn+lQOi1vn6XxZf06J3Io=" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="completed keyexchange" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=debug msg="completed challenge" Nov 03 03:45:04 volumio go-librespot[25615]: time="2025-11-03T03:45:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:04 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:04 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:07 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:07 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Nov 03 03:45:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:07 volumio go-librespot[25626]: go-librespot daemon starting... Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="app state loaded" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=info msg="zeroconf server listening on port 36999" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="obtained new client token: AAD5tvz7PWLQ3z53n9aUOjWQAUJfdzj8IwDKzAkvRal4P+mUonEF4TGxKGlb/vOTgwkBt1UYcHW3UauR5qTC39MA/OQMX7PtBRe/1j34LfwtrJdb3hSq3LZYzBmY71wsAtokgJ9568WPAkMaKcF1GSzZn47YAzMJCgwOtf84T0TgLOxpIUnZCW4jP+V4yaecAVG2FDlGpeySESVBVBr7iFggnto40fO4aoyev+SwOSv2YaeRWl5Ul0U=" Nov 03 03:45:07 volumio go-librespot[25627]: time="2025-11-03T03:45:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:08 volumio go-librespot[25627]: time="2025-11-03T03:45:08Z" level=debug msg="completed keyexchange" Nov 03 03:45:08 volumio go-librespot[25627]: time="2025-11-03T03:45:08Z" level=debug msg="completed challenge" Nov 03 03:45:08 volumio go-librespot[25627]: time="2025-11-03T03:45:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:10 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:10 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Nov 03 03:45:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:11 volumio go-librespot[25648]: go-librespot daemon starting... Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="app state loaded" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=info msg="zeroconf server listening on port 35681" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="obtained new client token: AACpOQxJREzuMjLIzrWZPcaQxpmtAQHrWwmEhbjWs7OztgxgYJkSTUW9Q3+qH/fusilGKY066cQjMXkR0GE7La7f0/gYPyrvTlt0iVBA+GizifvAIKt/BimXHYv4eHbXFq+fGJ1i6DQpTesi2AizAxYEBSYODPoudLysYv2QY6EVVohsv/wnSPoAgncbsgabzqMgD515SmrMB+U5M98mBZ0kzeywrtrHhJJ3iqxaNSRpb5BwifVoLn0=" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="completed keyexchange" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=debug msg="completed challenge" Nov 03 03:45:11 volumio go-librespot[25649]: time="2025-11-03T03:45:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:13 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 03 03:45:13 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:13 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Nov 03 03:45:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:14 volumio go-librespot[25656]: go-librespot daemon starting... Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="app state loaded" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=info msg="zeroconf server listening on port 40171" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="obtained new client token: AADoxf5s0kyNeite5AFNLvWOFnjcxemldi73/i/8PZK8cG9z+W2TeT3GxxoCZUgV9//bwd2m2ak710SX+M3NXVRDIK2oAXc4JswiWMXSsBywdi3rctwI/2gqqoq+V383iVjlauhQgYKRUN7dS3x7AHI48lAm3Lh8ENs/L7wRv+yJ4c/acNcIdCu9ZOAl4cIuwISKtShnlysxtwAJhFjw4lpA++YM9i+5vUpYF5EREui6nAMkDPFGkoY=" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="completed keyexchange" Nov 03 03:45:14 volumio go-librespot[25657]: time="2025-11-03T03:45:14Z" level=debug msg="completed challenge" Nov 03 03:45:15 volumio go-librespot[25657]: time="2025-11-03T03:45:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:16 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:16 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Nov 03 03:45:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:18 volumio go-librespot[25664]: go-librespot daemon starting... Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="app state loaded" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=info msg="zeroconf server listening on port 43741" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="obtained new client token: AAAXQZ5pxdL0+hMMz9Vj+DEMN/RNfHtsejXS6bRuKXvWO9+gr8mN/v/YPOmRcNpfyZBrqbr0fjXI9Qz1I7bmGVpY29dCm90/A8cyyCD0ZmhfDdRXzfQq3ehXReUmQrJIrMRJaV37Se+UYVYdyiYcBFjRg+eRpOj3p5UQLqpoNFW27AV1+OM/U4FRN2nOrrRBtQcwHxxnKYtfvRsjo6FbFN5VBvVPewHoAh/chZg0Fg5JZZNPEPvYY7Q=" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="completed keyexchange" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=debug msg="completed challenge" Nov 03 03:45:18 volumio go-librespot[25665]: time="2025-11-03T03:45:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:19 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:19 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Nov 03 03:45:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:21 volumio go-librespot[25686]: go-librespot daemon starting... Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="app state loaded" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=info msg="zeroconf server listening on port 40901" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="obtained new client token: AAAIMfBr8XI+LVflP2g6GkMZixQ/ajTm9j21lAUmPJKbVhngaMtX38B4Z9TR+30GuvKM5IoyP786D7CGZ055p6H34XMDCcFwTYVYc/gl4OpWIXjuVTZ6GP5bTbsW1M9LQi02oGtlKnqROhoz1en5ad8R5ORyUxCRK98B5k0kZ9ra8e+YjCVjg2FRQXSl8Z5PHdCtYIQ3WaU6G4LnM1OcYnBJcpMA5GrxzpV0QmeEEXe368isbZMkvv0=" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 03:45:21 volumio go-librespot[25687]: time="2025-11-03T03:45:21Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 03:45:22 volumio go-librespot[25687]: time="2025-11-03T03:45:22Z" level=debug msg="completed keyexchange" Nov 03 03:45:22 volumio go-librespot[25687]: time="2025-11-03T03:45:22Z" level=debug msg="completed challenge" Nov 03 03:45:22 volumio go-librespot[25687]: time="2025-11-03T03:45:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:22 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:22 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Nov 03 03:45:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:25 volumio go-librespot[25695]: go-librespot daemon starting... Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="app state loaded" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=info msg="zeroconf server listening on port 40479" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="obtained new client token: AAABWTEjjNWNqz25Z1AOFV7j4Jr2qUESTkxn65K9ONCOXbtzWnT1vgkfdWQCBAE6OKXpsbvK/XunGc23TpIjtw0bR8UsnLTSvvdBpYkJFGy1QUSSWtsozMCwRHFb3acVzPA318VsID2vevJzknovzcB0I6uTCx5vzHCEgstazBtUqudMg4RNy+f4DYG1gE+sfoW/G5BH7TWBZZDs7/2R9g4f2nkk++iFSe+ti7ld0egmk0x+Psh5Tbc=" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="completed keyexchange" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=debug msg="completed challenge" Nov 03 03:45:25 volumio go-librespot[25696]: time="2025-11-03T03:45:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:25 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:25 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:28 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 03 03:45:28 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:28 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Nov 03 03:45:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:28 volumio go-librespot[25706]: go-librespot daemon starting... Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="app state loaded" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=info msg="zeroconf server listening on port 37701" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="obtained new client token: AADgTB4+4lpfRF4cc9YMiFAv3WojHZwEAFRss9HgmANYr1obzZFgceI1LxAzQMRw9UdwNVDHJWKvb3jC96g6Xh5CgvU1LeDEODWFYpCG2S/1KPJzrcGj+QaHidxWUnkRQQIk9ABUszfsouPk8Kto4hRwHig//sziU0hHABC8GqkaKh+kFlJdlz/jpvmmIOhFZagLNuK8KCItvuYE+Keqin5SH+XsJp56zqb/NIiojojPdVzpgZ9tGkU=" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="completed keyexchange" Nov 03 03:45:28 volumio go-librespot[25707]: time="2025-11-03T03:45:28Z" level=debug msg="completed challenge" Nov 03 03:45:29 volumio go-librespot[25707]: time="2025-11-03T03:45:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:31 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:31 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Nov 03 03:45:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:32 volumio go-librespot[25728]: go-librespot daemon starting... Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="app state loaded" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=info msg="zeroconf server listening on port 43211" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="obtained new client token: AABWrvFYMp04/JdwJ1FKi4T3gEhRjSKXT5oQ6oJvxMn4eaLOHaOM9as6HTrFjs6qvKCMTXNkGh6vFLo/X1JowIU+hnXTlV0HxPR+UkgGErpcCFcxN2AYbv+VEugmcK3gAZCzOQ6bPtyEd2V03DvSrCa4yKT1ytUMvxSybPLJA1D/BmtfMEcJc9gBuAINBz9TOiQsGD6RQbNuTbhjCO46VExABXCpK7TSMOYL+F36L8V9KDCKlilgIfo=" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="completed keyexchange" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=debug msg="completed challenge" Nov 03 03:45:32 volumio go-librespot[25729]: time="2025-11-03T03:45:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:34 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:34 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Nov 03 03:45:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:35 volumio go-librespot[25736]: go-librespot daemon starting... Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="app state loaded" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=info msg="zeroconf server listening on port 38825" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="obtained new client token: AABk13RRzQI5sCL643jrSNF11+0Ry6WD3xTfi7uGik8TsUkEb6E7UZYMqM3dt25cBtc7IS/xEA0Jr2eoSEc+ja+SG/AHjwPI0RZ+7tskfnEp7uEJFr2NJ3wH6O1Nfqf1EYapklOZHt37meBsM05NMBFaJl38h/tRWrA+gNPWOdJ7M7Bf0MNzmdglsbsn1yxi7zSJyhcvazjWxETXz+Z2ezUJ/yCQk9zHNK/JqVS6aLKpI3/raU7GiXI=" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="completed keyexchange" Nov 03 03:45:35 volumio go-librespot[25737]: time="2025-11-03T03:45:35Z" level=debug msg="completed challenge" Nov 03 03:45:36 volumio go-librespot[25737]: time="2025-11-03T03:45:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:37 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:37 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Nov 03 03:45:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:39 volumio go-librespot[25744]: go-librespot daemon starting... Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="app state loaded" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=info msg="zeroconf server listening on port 45993" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="obtained new client token: AAA8BY89E0SdZMIVsGgiA+qNNO1xXBwWnEBCVW+rR+vZJNEegI7ohFgL0y/XRWw4WPeUfLXta5EGbMCsAFko0GMAB38U4GnvroM7Y6ixyugUm+aysJupY7YMLkkYRI0Zy/4ujad5+6TcWV8JmuSEnDvRZ4qwbBH6c3si0766AynVfleF+NUvWlmVc0BhbyWrIFBtta+myeSPfeXqG58vIRuW7Hrw8QzYbvOpJKLIFkLpAU5uF1MNoOY=" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="completed keyexchange" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=debug msg="completed challenge" Nov 03 03:45:39 volumio go-librespot[25745]: time="2025-11-03T03:45:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:40 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:40 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Nov 03 03:45:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:42 volumio go-librespot[25768]: go-librespot daemon starting... Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="app state loaded" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=info msg="zeroconf server listening on port 38541" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="obtained new client token: AADT8OLmAM5lq9fnwkpi+JQphM0+Peh2hWieWAP0UmIHX2/u8jOePphNMXvCuj6xK0L1sTZKxKl/0GrWnqtAHnRF4VzK/uoWJ4xA68K6oAQ9jK40OqJOtAOBE2gxgyw6DGytEvrWSTwEI4jbRSty1TnoDcfrqpebcBvVJQkAtRuo0Nly18k22yp4c74FIRAmYXJK24sWEuQUnEmSEsULvuINOgWCP0zd07Jm37s2FVANlTvxuaOQgZQ=" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="completed keyexchange" Nov 03 03:45:42 volumio go-librespot[25769]: time="2025-11-03T03:45:42Z" level=debug msg="completed challenge" Nov 03 03:45:43 volumio go-librespot[25769]: time="2025-11-03T03:45:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:43 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 03 03:45:43 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:43 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Nov 03 03:45:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:46 volumio go-librespot[25779]: go-librespot daemon starting... Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="app state loaded" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=info msg="zeroconf server listening on port 37999" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="obtained new client token: AACxTfUQACOwTBcE0pMBvnZGjOqnQnAINGfMJPB8vF9MJSk+cVk1JU0acR2BUVhs5DkBsh7kULsBA/RzjGZH/DhSQcETaEunEwzYE9b0jA0k+/26UaW7R2OCspt+sqICLomQ2TyRwr9Gw7i1x84QXggno9cVViyC/MQeFwGmfowNJiLdQyk3GoT25fZayyNRWrga8eNuOGWuAkPdJpHnqp2bTxBLiiZpb+BRUL/HXjPxAPisTUFkVEI=" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="completed keyexchange" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=debug msg="completed challenge" Nov 03 03:45:46 volumio go-librespot[25780]: time="2025-11-03T03:45:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:46 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:46 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:49 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:49 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Nov 03 03:45:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:49 volumio go-librespot[25787]: go-librespot daemon starting... Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="app state loaded" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=info msg="zeroconf server listening on port 35175" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="obtained new client token: AAAb+Bce3gqO6sARNkLFROHuo7NtzXLv2tst3ACIEkdwyxDuCaOUxX6ZvIYT3Xo4aMeCMZwv2EHDt2nEshQNpIMt/Z6xefLMXOuUastNoB98el39bBgolTwsKSQb+FyobPRi5/CR0ZFsiFnHiOFbYpfQbXuY9fz+MXjhyiJq3iEVYgUpRQUL9ziYolJbkjB92ICPr2Ngsar79NYiyfEAzpf4Y+Qlmw4TBGg2RxR+CGpBcuibLwkUPpg=" Nov 03 03:45:49 volumio go-librespot[25788]: time="2025-11-03T03:45:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:50 volumio go-librespot[25788]: time="2025-11-03T03:45:50Z" level=debug msg="completed keyexchange" Nov 03 03:45:50 volumio go-librespot[25788]: time="2025-11-03T03:45:50Z" level=debug msg="completed challenge" Nov 03 03:45:50 volumio go-librespot[25788]: time="2025-11-03T03:45:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:52 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:52 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Nov 03 03:45:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:53 volumio go-librespot[25811]: go-librespot daemon starting... Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="app state loaded" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=info msg="zeroconf server listening on port 37443" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="obtained new client token: AABi4ZrsOF73AdBvR1k5Be3lhPTmFIx8fab+g0/xfJXNO8L8fHWkAgApdUER9m68Wj9CjfdC+9pUQQuECxWVpTBjKtgpJ3W2p5eyyKrDtQE8xi4tl/aC39GAae/1T1UTPOQT9b5WT5h0ivm7gPjPv6WSdB7Zia1L8KmZwippo+xlj751xeV/7g8HwfKeKbnGA262GNqSGYAcijIQox5iZvdtZlpfcfbc53PvSO3Egumz40rA22Rmarc=" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="completed keyexchange" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=debug msg="completed challenge" Nov 03 03:45:53 volumio go-librespot[25812]: time="2025-11-03T03:45:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:55 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:55 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Nov 03 03:45:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:45:56 volumio go-librespot[25819]: go-librespot daemon starting... Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="app state loaded" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=info msg="zeroconf server listening on port 35473" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="obtained new client token: AAA4iIpqlM/QGRDR41/trplfNTXGUNSMYXH4GBi7Tgv855K2Ad6MnrCCtJaNWheQJ4/K49eDIDxpHenDlJxIZIGGc+caiawnZIEuVVl9F7YqJZ81/tloezAwUxQxKs6VhicSTJYPgIMa5zXLeOVZ8MTWIBy2FJ7exreq+rA1Xf7/K+izI/BgA6AWLoQX0MMGJJYeUI3f8pYIxwRzJfW7CjkiLUtn2QbgjmbSwu6tllyyeUfFyQXjrqU=" Nov 03 03:45:56 volumio go-librespot[25820]: time="2025-11-03T03:45:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:45:57 volumio go-librespot[25820]: time="2025-11-03T03:45:57Z" level=debug msg="completed keyexchange" Nov 03 03:45:57 volumio go-librespot[25820]: time="2025-11-03T03:45:57Z" level=debug msg="completed challenge" Nov 03 03:45:57 volumio go-librespot[25820]: time="2025-11-03T03:45:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:45:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:45:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:45:58 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:45:58 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:45:59 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 03 03:46:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Nov 03 03:46:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:00 volumio go-librespot[25841]: go-librespot daemon starting... Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="app state loaded" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=info msg="zeroconf server listening on port 39515" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="obtained new client token: AAAxpOlxcoLplsbM2QXs8x3aibG/MIJqr6KR+taFpKn9UHc3NgWW5dKY0g0oKID+35PseIbdme7sHzFxQSRnjNAyTtE+eJD9pbDXphWm/oLRUOQmvj5uTs/wy1+o6OV7cZ6p9WEWpGJyRTj4FSCLKatJoyrDZefAhCeSuozAgou6MMygDcs7iqgY4Rm9BZOHWYwS25t1PMXudNtw39pNrLPzqWB2Ubrx4C2UN1/mxTRCJya7bVXpVzg=" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="completed keyexchange" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=debug msg="completed challenge" Nov 03 03:46:00 volumio go-librespot[25842]: time="2025-11-03T03:46:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:01 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:01 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Nov 03 03:46:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:03 volumio go-librespot[25849]: go-librespot daemon starting... Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="app state loaded" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=info msg="zeroconf server listening on port 46077" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="obtained new client token: AAD9ubtmKXnXMES/CU3M5yiNG67aETIdO/ON42aDhIRHOM0H4AyGbJwmYICNQdERhm496hUi7RJkNR3G/PqImMqT8dJq/DnByaagpEuufS8SFzU19G8J4sMoKw0pYZrjXTb+3gEcKA7+qcbkQhndTDgHgqIO0GIXEfgZsYT7U0zBLG9MXSlZ7gNhHW9CCeSG+aAeSk3xMkeqnxDQZ4B3JRhkq+jorgjvv7lkdKI3OUUME/HKZNLVLXo=" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="completed keyexchange" Nov 03 03:46:03 volumio go-librespot[25850]: time="2025-11-03T03:46:03Z" level=debug msg="completed challenge" Nov 03 03:46:04 volumio go-librespot[25850]: time="2025-11-03T03:46:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:04 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:04 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:06 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Nov 03 03:46:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Nov 03 03:46:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:07 volumio go-librespot[25860]: go-librespot daemon starting... Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="app state loaded" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=info msg="zeroconf server listening on port 43809" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="obtained new client token: AAB6DOlUCiLVgk0Er12mBdScOy5xWrfoMskCDGa8aBr0712glTreg0EeyU0N0/T4Nx2m//Bvicav/WSltJ/xQJ6Gnvp8jmlHs4WZB+2iNQ8PvRPYR3ZuZ1tTPtz2CoU/TniUFocafUMoQlwbO2HfF5adzsL7WU0NAq1SVdjFBBhFIU9ea4kK+zaEqfYBf7PeSZzdurvXGoGEdrHPWPFIzMIZsbp34BiH2swA1+FGYEVlK3GZukIs8/Q=" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="completed keyexchange" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=debug msg="completed challenge" Nov 03 03:46:07 volumio go-librespot[25861]: time="2025-11-03T03:46:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:07 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:07 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:10 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:10 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 31. Nov 03 03:46:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:10 volumio go-librespot[25884]: go-librespot daemon starting... Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="app state loaded" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=info msg="zeroconf server listening on port 40865" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="obtained new client token: AACpzggYH5UeWYXzV6dIKahX4jzLRM8276HRYNywIh2hr6AyCZEKO0UYI9iGefbBwDSr8JGo8Jl8xd1ZKUVGZLVu7vPnFciahLCZtLdtxjqbMNYmxeUTgtzKQN5MEQ65SYukBEO9DdJ55WxojGJhro04dWo+KV//FMPkKPkXn2rj4D6lsR5HHPyngqYKXKW9uHiUXgBY2RcdoZ6Bv+sa1C0fsbiOSaQJ03A6zLBHW+58HkSnNWnaFGo=" Nov 03 03:46:10 volumio go-librespot[25885]: time="2025-11-03T03:46:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:11 volumio go-librespot[25885]: time="2025-11-03T03:46:11Z" level=debug msg="completed keyexchange" Nov 03 03:46:11 volumio go-librespot[25885]: time="2025-11-03T03:46:11Z" level=debug msg="completed challenge" Nov 03 03:46:11 volumio go-librespot[25885]: time="2025-11-03T03:46:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:13 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:13 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 32. Nov 03 03:46:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:14 volumio go-librespot[25892]: go-librespot daemon starting... Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="app state loaded" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=info msg="zeroconf server listening on port 43405" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="obtained new client token: AAC4Akw4c2858DIZJi8PRzsSJPNOFHCxGxjavWgIRjl7g6m2p5O/Fgzmt36CL0CuMXLNOHRu+c6L1BtziSBNWv+e+opK8rdaQFXtDpID2T6ZgFElLNxoMTmvDfN9P+gxW9EtrG+x6fVx5THzqXT1aCePb8r46I1SCbI/CQxpVpH187Cb61bH1jSAfPybzgzytYhXq+GB1cWax9LDmVjS6eqKUNMyP19ul/XMNU87BlRUjyMQe0JEIpc=" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="completed keyexchange" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=debug msg="completed challenge" Nov 03 03:46:14 volumio go-librespot[25893]: time="2025-11-03T03:46:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:16 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:16 volumio volumio[25143]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 33. Nov 03 03:46:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 03:46:17 volumio go-librespot[25900]: go-librespot daemon starting... Nov 03 03:46:17 volumio go-librespot[25901]: time="2025-11-03T03:46:17Z" level=info msg="running go-librespot 0.4.0" Nov 03 03:46:17 volumio go-librespot[25901]: time="2025-11-03T03:46:17Z" level=debug msg="app state loaded" Nov 03 03:46:17 volumio go-librespot[25901]: time="2025-11-03T03:46:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 03:46:19 volumio volumio[25143]: info: Initializing connection to go-librespot Websocket Nov 03 03:46:19 volumio volumio[25143]: info: Connection to go-librespot Websocket established Nov 03 03:46:19 volumio go-librespot[25901]: time="2025-11-03T03:46:19Z" level=debug msg="new websocket client" Nov 03 03:46:21 volumio go-librespot[25901]: time="2025-11-03T03:46:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 03:46:21 volumio go-librespot[25901]: time="2025-11-03T03:46:21Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 03:46:21 volumio go-librespot[25901]: time="2025-11-03T03:46:21Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 03:46:21 volumio go-librespot[25901]: time="2025-11-03T03:46:21Z" level=info msg="zeroconf server listening on port 45927" Nov 03 03:46:22 volumio go-librespot[25901]: time="2025-11-03T03:46:22Z" level=debug msg="obtained new client token: AADdpicFLoSinSqhrOoIb0jm9nolS/BMvudQZkXyYsvxbb1EHQ68SPTKfu9EjON2xnBBGLxFKDPCFzYP9n1sk6FxOi/0YQ1WDsW2cUXC/goihB/7KaU/1mkpaLKEsGRdTdp29vXMkTBFUDM9LxXmvRpQVyZrOdSifD2LLZkFHGcn/AjomKIsUDDD6pzkpzNyqwlekhu61Hd7U2P8AHuRthOGF17Iz/77RcTh6gJhBlNbSS9KpqjB" Nov 03 03:46:22 volumio go-librespot[25901]: time="2025-11-03T03:46:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 03:46:22 volumio go-librespot[25901]: time="2025-11-03T03:46:22Z" level=debug msg="completed keyexchange" Nov 03 03:46:22 volumio go-librespot[25901]: time="2025-11-03T03:46:22Z" level=debug msg="completed challenge" Nov 03 03:46:22 volumio go-librespot[25901]: time="2025-11-03T03:46:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 03:46:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 03:46:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 03:46:22 volumio volumio[25143]: info: Connection to go-librespot Websocket closed Nov 03 03:46:22 volumio volumio[25143]: info: Getting Spotify volume Nov 03 03:46:22 volumio volumio[25143]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 03:46:22 volumio volumio[25143]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 03:46:22 volumio volumio[25143]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 03 03:46:22 volumio volumio[25143]: errno: -111, Nov 03 03:46:22 volumio volumio[25143]: code: 'ECONNREFUSED', Nov 03 03:46:22 volumio volumio[25143]: syscall: 'connect', Nov 03 03:46:22 volumio volumio[25143]: address: '127.0.0.1', Nov 03 03:46:22 volumio volumio[25143]: port: 9879, Nov 03 03:46:22 volumio volumio[25143]: response: undefined Nov 03 03:46:22 volumio volumio[25143]: } Nov 03 03:46:22 volumio volumio[25143]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 03:46:22 volumio sudo[25936]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 03:45' Nov 03 03:46:22 volumio sudo[25936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="c22b72a8acb34a699a626adb0a09a6b88ee7233a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="40400d6a6fa57cf20e36499e510876b3654e9c4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Oct 4 16:40:08 UTC 2025" VOLUMIO_VERSION="4.061" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="7f8ace80645f85765fa10c72d1769d04"