Nov 01 09:50:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 251. Nov 01 09:50:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:00 volumio go-librespot[4090]: go-librespot daemon starting... Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=debug msg="app state loaded" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50: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 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50: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 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50: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 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=info msg="zeroconf server listening on port 33067" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=debug msg="obtained new client token: AADyiz1XLCFQkuLdt+QRQx6ItQBzpaG9G57Logjgx1N+q3xqDvu0VUdbL+gCWaq2narM2+VU5wUXmzoiSr+oRgAjHGKgHTPYkNKFOLJdosox2jjY64Hopyrjnvy4+8X5M6eF+IbzXqZqnB2stqLExpZSICIvz7pjm0h2c9Ffl9LkWwzPr6NWd+1sgzZdVyRz1ELIs8hLfIIYKiaEkff9KDlm+FINvkHJRGvra7Z4+jB912jii1DVRKE=" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=debug msg="completed keyexchange" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50:00Z" level=debug msg="completed challenge" Nov 01 09:50:00 volumio go-librespot[4091]: time="2025-11-01T09:50: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 01 09:50:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:02 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:02 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 252. Nov 01 09:50:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:03 volumio go-librespot[4113]: go-librespot daemon starting... Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=debug msg="app state loaded" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" 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 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" 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 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" 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 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=info msg="zeroconf server listening on port 35191" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=debug msg="obtained new client token: AABJsI1/uy3dSAsO0cUjuXeXJiBSNgZModGyhDmq3oZrC2xFvkmyRCJWAaMpn8grL03kSr7LU4nK04w9C8eMaS0T4iTmeKZoows9aEfaB6Nywq5dhRPPHo5iT7MKty0DqRUbl77ZzrNm22X241u2fwi5jPbNqewkyXgWXVtlJJ+GRJOOvUNzoY4KonVplAOu5Qmz0N4PoADOf47so/k2GuJr12zhqZYdZAmckM2EOTEtkoAlwUkN+z8=" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=debug msg="completed keyexchange" Nov 01 09:50:03 volumio go-librespot[4114]: time="2025-11-01T09:50:03Z" level=debug msg="completed challenge" Nov 01 09:50:04 volumio go-librespot[4114]: time="2025-11-01T09:50: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 01 09:50:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:05 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:05 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 253. Nov 01 09:50:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:07 volumio go-librespot[4124]: go-librespot daemon starting... Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=debug msg="app state loaded" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" 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 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" 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 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" 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 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=info msg="zeroconf server listening on port 40685" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=debug msg="obtained new client token: AADufCbHiQqInx+98eLJVHWPTsdxhuxNYKKsoA4uH/VG2bSurga/+cpFDmp9pqAwzoGC2imWuqey5eC3KXCi66EW1QOYPL8Wi0Gv5W1p/gB5+KeJtbXDDPgja64xWndHmBB6N0IxqJcG9gew8UXPHApDq/jiwTGfABa1SARJxVRLVyp9jwDKx6tJBEPkws1ZbQZ+80539p6rE8ZcqVZMaoe4PDTl5Vfu6CWTZ3B48iJKwAKWqFjMLYg=" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=debug msg="completed keyexchange" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50:07Z" level=debug msg="completed challenge" Nov 01 09:50:07 volumio go-librespot[4125]: time="2025-11-01T09:50: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 01 09:50:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:08 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:08 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 254. Nov 01 09:50:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:10 volumio go-librespot[4132]: go-librespot daemon starting... Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=debug msg="app state loaded" Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" 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 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" 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 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" 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 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=info msg="zeroconf server listening on port 45453" Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=debug msg="obtained new client token: AADItIxX3+AtlWhSgt7rZgkCjf6UoAHPQyzSyoCqvGeQpbvC2q1erHeFelrgLOIiobxQQw5FAN35TU+tLt4NxcrHv0FsXgP7k1GecdcSlmsUEnMHDrgDu67DyDMt9xm9PrZiRYg9L3+/UvFLGFIOpY6C9L8slOefXQHm3F6bB0U7TrLHFV+pwWMivC8R/Wp0EdcKlWPvALsMU3pYuNwfVgEO59APDYJ6w+amXe0NxlnRR8AgX+IFn2E=" Nov 01 09:50:10 volumio go-librespot[4133]: time="2025-11-01T09:50:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:11 volumio go-librespot[4133]: time="2025-11-01T09:50:11Z" level=debug msg="completed keyexchange" Nov 01 09:50:11 volumio go-librespot[4133]: time="2025-11-01T09:50:11Z" level=debug msg="completed challenge" Nov 01 09:50:11 volumio go-librespot[4133]: time="2025-11-01T09:50: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 01 09:50:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:11 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:11 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 255. Nov 01 09:50:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:14 volumio go-librespot[4155]: go-librespot daemon starting... Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=debug msg="app state loaded" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" 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 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" 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 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" 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 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=info msg="zeroconf server listening on port 43953" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=debug msg="obtained new client token: AADKTprNkzO5kAr3xFPO/eJ74W1Z7471/CLDErvtEps9+tTqWX6IcQEGkZw2LItCvui8lqZQOVtlhYR07LLWpzDOdZiOtaMgGNPjai8d09Z3MnB2l9hShzU1TP5APM7g3KgkpLRgFA4dk+JEzGGzwplhG5q1lDFGhnpbqH7CRGXmsSggEXCy4Rupgkt9/S7AUGW9fS7r1eNZ/v1frO9BdOwIbLyeX+bV1tomKgqrBO1p+EzajVfl8dU=" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=debug msg="completed keyexchange" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50:14Z" level=debug msg="completed challenge" Nov 01 09:50:14 volumio go-librespot[4156]: time="2025-11-01T09:50: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 01 09:50:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:14 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:14 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:17 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:17 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 256. Nov 01 09:50:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:17 volumio go-librespot[4163]: go-librespot daemon starting... Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=debug msg="app state loaded" Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" 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 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" 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 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" 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 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=info msg="zeroconf server listening on port 43227" Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=debug msg="obtained new client token: AABY8b9EDY8OJKq5fGh5TWfVDz5Me9zuKoKbPid5nPZTAUahJQ6aqjV+ubWMeQI5qkrH93CMs9PMWArrv2hMb/K/m+6bhtnzxlvlNu4tB5VWJKyX0BCkPkw9Fa7LrqZl9MzY354zaUalHBXmpLxM057FrtBlzI+cGhtp8xKWsGTuxmkRBUXQBIGa4F8ry4/oFEloSgyJCaY2zXevu9OEBgY9D9ELp4YPWRgO/idHq3Ik446Y9YhPG9k=" Nov 01 09:50:17 volumio go-librespot[4164]: time="2025-11-01T09:50:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:18 volumio go-librespot[4164]: time="2025-11-01T09:50:18Z" level=debug msg="completed keyexchange" Nov 01 09:50:18 volumio go-librespot[4164]: time="2025-11-01T09:50:18Z" level=debug msg="completed challenge" Nov 01 09:50:18 volumio go-librespot[4164]: time="2025-11-01T09:50: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 01 09:50:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:20 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:20 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 257. Nov 01 09:50:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:21 volumio go-librespot[4186]: go-librespot daemon starting... Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=debug msg="app state loaded" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" 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 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" 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 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" 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 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=info msg="zeroconf server listening on port 36611" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=debug msg="obtained new client token: AAA1f6QV442MuN0b2hTlLnCzwNzloFMjVquTK3fUqkGzS0pueJZ3viL71UXeeYkPL6hw3zt6r21u6maFF5Fz+Ho0IZOcDflzr+7Yk6D7nFsg/7Dn8aIbKQOu8C6GrrYJCvVrD5BPMPpHY6AbJbmp1agRh62IUy0XWbc2ldvZIG4vBeKnKpO2PQR2MrFAIC+0XblqWDDmDfv19poXuFGZEzbNOgXBc3/yl4yv1IdJjw7VlqM6VpF3ZzM=" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50: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 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=debug msg="completed keyexchange" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=debug msg="completed challenge" Nov 01 09:50:21 volumio go-librespot[4187]: time="2025-11-01T09:50:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:23 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:23 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 258. Nov 01 09:50:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:24 volumio go-librespot[4194]: go-librespot daemon starting... Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=debug msg="app state loaded" Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" 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 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" 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 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" 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 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=info msg="zeroconf server listening on port 39365" Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=debug msg="obtained new client token: AADjkbQ1OvirPOKYcNYBehcD0Cma4Z++AUK114JT4hirRMEHQYqZL5hhdRHl9k1+ikRtgceOGaXOFULtiZYtfW/04Fpx5J7+Cgm/TMkJ8HNG3v5nVYh9LMO70fBxxf/VcbMgSGeM8pO4KJBdLy1QiYeuhNXPejg41/hfmzl56T8RxpK9vVWoyFFS4WCtPUnam6Tdu8gyfLj01YJ0IOJKoL7O6sPmToaKN/7hCZBuMSEsBqYZypa+qyo=" Nov 01 09:50:24 volumio go-librespot[4195]: time="2025-11-01T09:50:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:25 volumio go-librespot[4195]: time="2025-11-01T09:50:25Z" level=debug msg="completed keyexchange" Nov 01 09:50:25 volumio go-librespot[4195]: time="2025-11-01T09:50:25Z" level=debug msg="completed challenge" Nov 01 09:50:25 volumio go-librespot[4195]: time="2025-11-01T09:50: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 01 09:50:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:26 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:26 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 259. Nov 01 09:50:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:28 volumio go-librespot[4205]: go-librespot daemon starting... Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=debug msg="app state loaded" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" 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 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" 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 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" 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 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=info msg="zeroconf server listening on port 38905" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=debug msg="obtained new client token: AABr2AcCYZFq27GMCUa0JWUPW4mwifhF15DGb10i4ZpinLf8OJN+OtFR88OFkg5LdL//HPsAxxB+b97ySGiTqxqkMEIYHI2sTeYWAN5AZBdy7DQHO5ttAg16kVVe4uECcI4nSqvQ2lCBcLTdhKVKOQ5TiwwQu8SMUjKmDM01+5YQ83lr0dma3d0HBwvRErY+F9i5pQPnmezz+G1B/DRi+fvaTQZJlpN7p4I0qrGNEUVsKUWyJ3gkUPE=" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=debug msg="completed keyexchange" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=debug msg="completed challenge" Nov 01 09:50:28 volumio go-librespot[4206]: time="2025-11-01T09:50:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:29 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:29 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 260. Nov 01 09:50:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:31 volumio go-librespot[4227]: go-librespot daemon starting... Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=debug msg="app state loaded" Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" 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 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" 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 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" 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 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=info msg="zeroconf server listening on port 42749" Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=debug msg="obtained new client token: AAAZJYpqJ/MzPL7/+nvKyiB1ZK1GjvCTu5XJuCSqeqb1gyyK1MKIUBhRm95aERpIMAburnc8Tak1C1p2BHuKew3bCNXz0anNTEITKH6GeCo2izdabiOTLX23EkWc9kb3dVlHsBuibi6U5EisDDP2bP565wY/gxB6M5fpfpwZfpwEuQEmUwaC8xWNGlIFwUPTJdYxVAlKGhDIkmijq4KKiiW9XYs5/+xXMEEl49Pzh+Th78skrB8mq9U=" Nov 01 09:50:31 volumio go-librespot[4228]: time="2025-11-01T09:50:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:32 volumio go-librespot[4228]: time="2025-11-01T09:50:32Z" level=debug msg="completed keyexchange" Nov 01 09:50:32 volumio go-librespot[4228]: time="2025-11-01T09:50:32Z" level=debug msg="completed challenge" Nov 01 09:50:32 volumio go-librespot[4228]: time="2025-11-01T09:50: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 01 09:50:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:32 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:32 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 261. Nov 01 09:50:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:35 volumio go-librespot[4236]: go-librespot daemon starting... Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=debug msg="app state loaded" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50: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 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50: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 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50: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 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=info msg="zeroconf server listening on port 38861" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=debug msg="obtained new client token: AADZxYUkxQMsuBzh7uOoYGV5HNoSuxUH7SwcH1n8fcHM7XLG1qgiZoldJAoQ4z5gPXpiGiO1hkZVFbVENu0DA7tj9FMU6ssnHwe2fV39jhVfnRrSzYRrU4YEG51fznDrRu3aRnl8IfKMUURvBLV/PbTEPQTk7lvbzYiuAMAn+lIgiLuoDuQ15zgpVwPseD0qHiZfLcXUjKfJOFOLb6oe4RjThWDbaG3HtxvO767hmMtjUkU0eUP/HGs=" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=debug msg="completed keyexchange" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=debug msg="completed challenge" Nov 01 09:50:35 volumio go-librespot[4237]: time="2025-11-01T09:50:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:35 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:35 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:38 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Nov 01 09:50:38 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Nov 01 09:50:38 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Nov 01 09:50:38 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:38 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 262. Nov 01 09:50:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:38 volumio go-librespot[4270]: go-librespot daemon starting... Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=debug msg="app state loaded" Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" 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 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" 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 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" 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 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=info msg="zeroconf server listening on port 41371" Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=debug msg="obtained new client token: AADSzpiLJx2UnvaEHQdIYr9SIbKk0vOW7I8Hv+f55KaKLGMWH6MeHC+GWCmNlUsvrF4hUwPUHTbxY85B7VNBMLY5QR1n8MlnipY4lCLg4e2snrN3OhEk2BUO1G+az2RFlqdwzFi/NXY+qrPAdsWjuxAHPB3V3xO8NZ1O+ZgSQHrKde5018ybuFcGPzcUQ4K0XHkzO0JEJWHg0OvdIjq0lRY/9E5u4tZg23YGWjUVaWDlBX6aQumnmVw=" Nov 01 09:50:38 volumio go-librespot[4271]: time="2025-11-01T09:50:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:39 volumio go-librespot[4271]: time="2025-11-01T09:50:39Z" level=debug msg="completed keyexchange" Nov 01 09:50:39 volumio go-librespot[4271]: time="2025-11-01T09:50:39Z" level=debug msg="completed challenge" Nov 01 09:50:39 volumio go-librespot[4271]: time="2025-11-01T09:50: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 01 09:50:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:41 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:41 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 263. Nov 01 09:50:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:42 volumio go-librespot[4292]: go-librespot daemon starting... Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=debug msg="app state loaded" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" 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 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" 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 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" 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 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=info msg="zeroconf server listening on port 45159" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=debug msg="obtained new client token: AAAyr1lBzuqGwzW/QrWuToMppaB/ClwlK5gvPB49Il7PAs18TZSRpOf/99EmD7bADXdHD76kr7Q5+mjfJmkq6CqjGDF9lZ+irqZgv8U0mDNTXVnN7N9C92d8l6RbYTNYR9Ki2Su5CcN11KCAPYBWBna800+2YVf/HjHNlCAVnZZgqARXOmKRHqILL24IdPEKIOw+cNwO1GrqkvN0fbs4x0xony8YooJ+h7dNsCslhZRcNFzTTISVB04=" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=debug msg="completed keyexchange" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=debug msg="completed challenge" Nov 01 09:50:42 volumio go-librespot[4293]: time="2025-11-01T09:50:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:44 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:44 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 264. Nov 01 09:50:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:45 volumio go-librespot[4300]: go-librespot daemon starting... Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=debug msg="app state loaded" Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" 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 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" 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 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" 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 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=info msg="zeroconf server listening on port 41931" Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=debug msg="obtained new client token: AAAgcVdGVIXiW2OLat1acvVrf0p3yNsglPOGh+hDhhCS28FTxnN9saz8iAy+KO/Hrwxr+N1hlRl+2VJM3TN7Vd8ZervJZ2G2o1+AyPgqiDquU+ck09zuSHvj864i75R4sfkX23ARWiyni/T02g2Qq2dr0pyc8k+cb1KnXFYyH4GAsfv3nA3gx9pZOg2s8g8u7EmrCOCIaIy+WWT2oNEAxJ4ur9NR90HFKNh7uQArvUYPAortSWWnXvI=" Nov 01 09:50:45 volumio go-librespot[4301]: time="2025-11-01T09:50:45Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:46 volumio go-librespot[4301]: time="2025-11-01T09:50:46Z" level=debug msg="completed keyexchange" Nov 01 09:50:46 volumio go-librespot[4301]: time="2025-11-01T09:50:46Z" level=debug msg="completed challenge" Nov 01 09:50:46 volumio go-librespot[4301]: time="2025-11-01T09:50: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 01 09:50:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:47 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:47 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 265. Nov 01 09:50:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:49 volumio go-librespot[4311]: go-librespot daemon starting... Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=debug msg="app state loaded" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" 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 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" 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 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=info msg="zeroconf server listening on port 44765" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=debug msg="obtained new client token: AACymS/gKgtf/2T8hV70A4xotg/3DYP+o4bxui2Hut+sWqhBg3d1FVJnmgL1eUF+jj+J+D/oMeo/28wJTVb+Cgaat9q+dHi1SnpBqH4+eOLX0XBvCp4tRyZSVS/W8hSywKC1dwd3pLNE8QMsquU1KjgLvPrX9J5p6Pg+Bs0Dp8zTmWeR5EFURgClYHZgla+xLLaITdAvHejgqpIg4oqoVkPcY9Cwd8DyzssYak7c7abGcy/7HtLjQns=" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=debug msg="completed keyexchange" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=debug msg="completed challenge" Nov 01 09:50:49 volumio go-librespot[4312]: time="2025-11-01T09:50:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:50 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:50 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 266. Nov 01 09:50:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:52 volumio go-librespot[4333]: go-librespot daemon starting... Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=debug msg="app state loaded" Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" 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 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" 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 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" 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 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=info msg="zeroconf server listening on port 40043" Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=debug msg="obtained new client token: AAD04ovAsUcn3HPjXxZAVzXBvswCFkDLUtQUP/N35Gz6aDIIVjXfsysoc8NvSRayvwTGf8p3r/0joDg+ESzd7xVnN8pSdn0V1F5r4DBmyGaKj1aTs1VkdXVp01NoOvVSSH35cfbStidedkkeZkAPPCIEGQsDItfOX/gxiMs2MipKq4LDcv3HaWYjtOIFh0fqX22AmsG9vzko5yKInrrtapzTltylEr7QNKUp97iFDaCOsf65DXrW4DI=" Nov 01 09:50:52 volumio go-librespot[4334]: time="2025-11-01T09:50:52Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:53 volumio go-librespot[4334]: time="2025-11-01T09:50:53Z" level=debug msg="completed keyexchange" Nov 01 09:50:53 volumio go-librespot[4334]: time="2025-11-01T09:50:53Z" level=debug msg="completed challenge" Nov 01 09:50:53 volumio go-librespot[4334]: time="2025-11-01T09:50: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 01 09:50:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:53 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:53 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 267. Nov 01 09:50:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:56 volumio go-librespot[4341]: go-librespot daemon starting... Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=debug msg="app state loaded" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50: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-gae2.spotify.com:80]" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" 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 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" 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 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=info msg="zeroconf server listening on port 34733" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=debug msg="obtained new client token: AABCO5o5UKHWFDKv1wVGMoThy50uPAWRatl6F/oSM/BUYKDL0tNqb4blVq6nnmPbHdauuzPOqDTObo3TQ4gxsJ5htW2689RygUY4cm7JZUQAoGUjvHlpPPEmtkN67/tqNZ/LrDSScwY31siB+yuhnoB+PbRh9N+Mb49ukqxd2N6GVV7mRuYrTFdVQK1Cc4ZcpLnP8fgIeIwIIGyktz0KC5tK/yaY0pPmpZYTsVW8BQMD+0P1xYm1IGs=" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=debug msg="completed keyexchange" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=debug msg="completed challenge" Nov 01 09:50:56 volumio go-librespot[4342]: time="2025-11-01T09:50:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:50:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:50:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:50:56 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:56 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 268. Nov 01 09:50:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:59 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:50:59 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:50:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:50:59 volumio go-librespot[4350]: go-librespot daemon starting... Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=debug msg="app state loaded" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" 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 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" 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 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" 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 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=info msg="zeroconf server listening on port 36749" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=debug msg="obtained new client token: AABRX0UJqWhxdQya0ptuG2BGR/d7//mHw3N2ZRQhZNFcxY1CTrzgPL5kGq3qZWsQIomheYuot22dQEapcBOJf2rXtpJ3nioTltn82H/bppoc9108Q9t0WiWgpcglgxrigxBPHNn38Eyaeok5yHIWYduaz/juJ65+DDDXuzZzNvW6oJkPqN+FlGby/Z36qkLUYXLuKWRtqnYu+OVeBPxz6JoTx4q0xL9fxkhEwIxIXN8IfYKzIvuBOGk=" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=debug msg="completed keyexchange" Nov 01 09:50:59 volumio go-librespot[4351]: time="2025-11-01T09:50:59Z" level=debug msg="completed challenge" Nov 01 09:51:00 volumio go-librespot[4351]: time="2025-11-01T09:51: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 01 09:51:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:02 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:02 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 269. Nov 01 09:51:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:03 volumio go-librespot[4373]: go-librespot daemon starting... Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=debug msg="app state loaded" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" 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 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" 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 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" 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 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=info msg="zeroconf server listening on port 43479" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=debug msg="obtained new client token: AAD299HmL5t482FS0+lEieivSxO2g8JSe2jvwQZUVDGHlptRzhbfDr5/aBenUWMsv9/EpT+Iy1q/l5tboUViaTgLJf5EhphqMKlO4s+b4gezP0lqp87B9sSUykiKIPu64cx/3gs+IvmGBE3d4EGwAPo8zYaPVnr4RxrWb9BvwN8Zx6DxZmeAN8xmgYX4lmH1PPIeHCzux4l2gMZ1qmmaXajJ5YHMqjt+rbVIqPlh8zuBiQLNPWwFGuU=" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=debug msg="completed keyexchange" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=debug msg="completed challenge" Nov 01 09:51:03 volumio go-librespot[4374]: time="2025-11-01T09:51:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:05 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:05 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 270. Nov 01 09:51:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:06 volumio go-librespot[4384]: go-librespot daemon starting... Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=debug msg="app state loaded" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" 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 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" 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 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" 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 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=info msg="zeroconf server listening on port 36561" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=debug msg="obtained new client token: AAAnW+EY+KDWLOY5Y9xXIl9aUV0i8D6vZT4FPmlU5GgfdbWpCEWLB6RwJpGnzKo+19Fh5WEMi6kBild1BqVrzeNQc499kKhlZ1KdjaRuPCLcXO3ENfTL8S9mPS+YRlM+aRwaqkhEUyYTxfjH7VzxBTpFGmONQx/2CAG8udOBEwYsrsL4Si7+7E3QCsEjiT07alRA4nkUdcQgB6iVoe7zGauaHGFYtU71KHQmb+V2thX9aP1qP8w8nLI=" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=debug msg="completed keyexchange" Nov 01 09:51:06 volumio go-librespot[4385]: time="2025-11-01T09:51:06Z" level=debug msg="completed challenge" Nov 01 09:51:07 volumio go-librespot[4385]: time="2025-11-01T09:51: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 01 09:51:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:08 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:08 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 271. Nov 01 09:51:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:10 volumio go-librespot[4392]: go-librespot daemon starting... Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=debug msg="app state loaded" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" 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 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" 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 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" 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 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=info msg="zeroconf server listening on port 39749" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=debug msg="obtained new client token: AAClmAr1/jmnPwXISCPImMfN9d5EpuD2KI3sppSqZqEujtuvN5L1xmpWRnzheH7sxKLXX4y2TtO2jXRkFGf7QJTrF1dOPSUt9MUtPodB/LjNh00kIem9kJrhu1n0i+DGTO2RWZWw8Cc5vWtRdxQoLyrbwVkhzzU6n/qecnmgOBEW3voj/vpnZ4hAjWVU8BuSq5t1e2x7ojxVVdMWI7o4MtgYGSGPfqsBDU+yqWoeG/RZ7N2/qqZPb28=" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=debug msg="completed keyexchange" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=debug msg="completed challenge" Nov 01 09:51:10 volumio go-librespot[4393]: time="2025-11-01T09:51:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:11 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:11 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 272. Nov 01 09:51:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:13 volumio go-librespot[4414]: go-librespot daemon starting... Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=debug msg="app state loaded" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" 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 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" 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 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" 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 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=info msg="zeroconf server listening on port 37401" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=debug msg="obtained new client token: AADE0zjpUNIAvdkgHvwhYT71qpUMMmxX+yUn0o1A/d1h4MV4jWmN1G9AdQjRq9EaKccVWN9rAsatKCNkjQmTa/R8fia/t3b5IlHWcyWpknNkA0JgwvOBGY3NVC55vX+E39nseh+hMriBDPEBpCztUff97U36kJiNxDhcZmLODtcWFkoP0QboWDLtwFdsdOyi5IDFpJwjgU7QrKhHZuhujcQAxkb0K17Bbxe5xWutC/4wJvrqYI8SpMo=" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=debug msg="completed keyexchange" Nov 01 09:51:13 volumio go-librespot[4415]: time="2025-11-01T09:51:13Z" level=debug msg="completed challenge" Nov 01 09:51:14 volumio go-librespot[4415]: time="2025-11-01T09:51: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 01 09:51:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:14 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:14 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 273. Nov 01 09:51:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:17 volumio go-librespot[4423]: go-librespot daemon starting... Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=debug msg="app state loaded" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" 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 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" 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 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" 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 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=info msg="zeroconf server listening on port 38347" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=debug msg="obtained new client token: AAALhUgekKwoHvhurKoLH7TLsPKIXFXRvJc8M0ozZsgslkZ05fIcykI+SLpHY59p1m7Z7ni3mKO6wuq184QFeKkHiofroMMhTZ8rGjk7Iv3rAkqNais2RAlkStd9jYucMYtzBdSE7B/dFhNdxtjTO7Rwm62q6vtL+CBqUXhaQWSbScGO2BcutqwLNsXQGQ5U56Y5hdvPE3sB6OwrUJHF2YgW7Lf/2XKqUcMMsPTly/6VENClTMsv+K4=" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=debug msg="completed keyexchange" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=debug msg="completed challenge" Nov 01 09:51:17 volumio go-librespot[4424]: time="2025-11-01T09:51:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:17 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:17 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 274. Nov 01 09:51:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:20 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:20 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:20 volumio go-librespot[4431]: go-librespot daemon starting... Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=debug msg="app state loaded" Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" 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 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" 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 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" 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 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=info msg="zeroconf server listening on port 36547" Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=debug msg="obtained new client token: AAAYQyLA2wn3izKzQjYPrhDRNdFGXWg7uYRfxJyvLI2s5zDipRVaS/ZPUMFCHembCncvZfZ0X7hA94L6TIf/pQpjTHnRtReoloXJ0DVSPyHahoI7eDXSWPzmIAjFrOuZ1OiuHElMMRZvVNR2+r32Ywn5U+XWKcCIvjMe/aXjWNQn8WbTEn5r2ZEeFe/GbHj5V6pCSfsIODb3gUC8sBHuLCeOiNNq6OQqEf8hrxIxGhlTBKquRpMUXfw=" Nov 01 09:51:20 volumio go-librespot[4432]: time="2025-11-01T09:51:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:21 volumio go-librespot[4432]: time="2025-11-01T09:51:21Z" level=debug msg="completed keyexchange" Nov 01 09:51:21 volumio go-librespot[4432]: time="2025-11-01T09:51:21Z" level=debug msg="completed challenge" Nov 01 09:51:21 volumio go-librespot[4432]: time="2025-11-01T09:51:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:23 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:23 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 275. Nov 01 09:51:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:24 volumio go-librespot[4453]: go-librespot daemon starting... Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=debug msg="app state loaded" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" 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 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" 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 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" 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 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=info msg="zeroconf server listening on port 40265" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=debug msg="obtained new client token: AACRH5qj41UewqkeX7Avwi3jovpPXW+UzDqBPyzpeZ4XbIDYZo24LZIu9LLsmGgsdxyr5adK8UsV8bkrnbMszQ/ciaNvPTXTX9jlEqjNv8Wm8qQD/KYQ1pxLa8TNEiJFKTCcs+c5q/t0voJVijqLJrbJ9d2n6Y6IlC44FQnZEgbC4xS0pl8Xjq9qseBscLffAuE2jggsfSS91UHKN6haPY+iJdo/0VzoZSeRX6J0so3ZVc0QOSrmunE=" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=debug msg="completed keyexchange" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=debug msg="completed challenge" Nov 01 09:51:24 volumio go-librespot[4454]: time="2025-11-01T09:51:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:26 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:26 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 276. Nov 01 09:51:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:27 volumio go-librespot[4465]: go-librespot daemon starting... Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=debug msg="app state loaded" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" 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 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" 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 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" 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 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=info msg="zeroconf server listening on port 42319" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=debug msg="obtained new client token: AAC9q1C33tzaz15hMzTv+1LI8wK3PxC4sEuPAH4RpWkGhCNS5V4JijNHaEOwmA/lI9W6py7sR0YQ6+5ii1qykopUahnwlA3eCYSruVEuRwmlICEqN3/CdmxsRv1syVZoK22WUTAQ58uBq28nTqcERpfHxqWtvBZIlCFbBozN34yO+up3uWAidTKWiLDQ8k0whtysNNusxl+xeYH7zOEyT6Uc/WdkMhcEodqzTftAII+cjo9j1YFSokw=" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=debug msg="completed keyexchange" Nov 01 09:51:27 volumio go-librespot[4466]: time="2025-11-01T09:51:27Z" level=debug msg="completed challenge" Nov 01 09:51:28 volumio go-librespot[4466]: time="2025-11-01T09:51:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:29 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:29 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 277. Nov 01 09:51:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:31 volumio go-librespot[4487]: go-librespot daemon starting... Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=debug msg="app state loaded" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" 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 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" 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 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" 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 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=info msg="zeroconf server listening on port 40233" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=debug msg="obtained new client token: AAC31R6Gp1eOyGhqf3NIDHAokJyfU671I8E/wbbhUvYKIEv9zDVcpxX2ao8jrkiFFcnAiGOgZgE7GaQAlPalkrEdojsoPd+TTGvVeeqkFPSR6ynlWbRiKUHz/UqEJ7CFrGH7KVamyoZnBdDmDbpMT1cnNecZbXjBSWUjQPw2r4HRA3FCh9U1abJ7m1Y8/LxGvWLI7Sy/QhtNHjTJBR2qcpjZK9lvg/RTL+1VeZEqn/5lo1tzdipLefY=" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=debug msg="completed keyexchange" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=debug msg="completed challenge" Nov 01 09:51:31 volumio go-librespot[4488]: time="2025-11-01T09:51:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:32 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:32 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 278. Nov 01 09:51:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:34 volumio go-librespot[4495]: go-librespot daemon starting... Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=debug msg="app state loaded" Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" 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 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" 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 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" 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 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=info msg="zeroconf server listening on port 35967" Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=debug msg="obtained new client token: AACvP/YutxEdnMx1DS/rcWBWAe2QDjRkh9bR59SZJ6FC/F4Wu0PXeOSpqU7UBQw+u5t4CWJq+g97yDi3pstFzRkpPZXoWyp0oyYX9mUiT8+ahzr/qH7T7O0sfJiMJNJUOOICFMbpZKheeS5VRlWQojW9XqhlqkMbMJG0pCknkGMhfTD58Yw7ZXse/IZXC4g7iHDRTBI2VBVg7bgF/5//11FPIt2t5ei5wdfi2IKUUuQbtbL5I7Cnw00=" Nov 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" 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 01 09:51:34 volumio go-librespot[4496]: time="2025-11-01T09:51:34Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 01 09:51:35 volumio go-librespot[4496]: time="2025-11-01T09:51:35Z" level=debug msg="completed keyexchange" Nov 01 09:51:35 volumio go-librespot[4496]: time="2025-11-01T09:51:35Z" level=debug msg="completed challenge" Nov 01 09:51:35 volumio go-librespot[4496]: time="2025-11-01T09:51:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:35 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:35 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 279. Nov 01 09:51:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:38 volumio go-librespot[4504]: go-librespot daemon starting... Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=debug msg="app state loaded" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" 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 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" 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 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" 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 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=info msg="zeroconf server listening on port 34463" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=debug msg="obtained new client token: AABMp4X424EwBcIrnJtVLpbhd1s4M8ypEgnRigKzN8cG62URgvfM2pKP0PvQY+SuN0nxr+BqnNDKIZucVlh7+P3QbTevsuxKYmpTfWROptROBesvX1THIFm8yg1HS6za7Isu6ML+sWAY+OCoOAchOQBzEYYy+zJe/Vltfqhuu5wZ/4AIovIXjsx53D2TOi2zvJE46oaLB9pfsuZ3qtHuYi3DxjZNJpQWH5wEHN4YE20TZF1/wKfMnJQ=" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=debug msg="completed keyexchange" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=debug msg="completed challenge" Nov 01 09:51:38 volumio go-librespot[4505]: time="2025-11-01T09:51:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:38 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:38 volumio volumio[2941]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 280. Nov 01 09:51:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 01 09:51:41 volumio go-librespot[4526]: go-librespot daemon starting... Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=info msg="running go-librespot 0.4.0" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="app state loaded" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 01 09:51:41 volumio volumio[2941]: info: Initializing connection to go-librespot Websocket Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="new websocket client" Nov 01 09:51:41 volumio volumio[2941]: info: Connection to go-librespot Websocket established Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" 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 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" 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 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" 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 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=info msg="zeroconf server listening on port 35559" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="obtained new client token: AADjqcjWTdMZil8peK/8RIu501fOCtlNLIBHsbLKKGuc4amOBLRowYNQY1u5nZP+0jkyqtetdnyZYxJ+th0tqp3mBYRfWS+IEmxCkdxMmzwANxfkrSZY+ZLhBSIaVD6871nowfFgBVwH+xBA9H/mqTxw/0lk4K6Ud+ZGVLcMXQJ70tonQTPpLI+mSRg7LO0mgjWllQWxJDRNtruasBkrhXFX+DMC7Lwez/0/yXPZQwMWYciawxiWwRY=" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="completed keyexchange" Nov 01 09:51:41 volumio go-librespot[4527]: time="2025-11-01T09:51:41Z" level=debug msg="completed challenge" Nov 01 09:51:42 volumio go-librespot[4527]: time="2025-11-01T09:51:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 01 09:51:42 volumio volumio[2941]: info: Connection to go-librespot Websocket closed Nov 01 09:51:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 01 09:51:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 01 09:51:44 volumio volumio[2941]: info: Getting Spotify volume Nov 01 09:51:44 volumio volumio[2941]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:51:44 volumio volumio[2941]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 01 09:51:44 volumio volumio[2941]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 01 09:51:44 volumio volumio[2941]: errno: -111, Nov 01 09:51:44 volumio volumio[2941]: code: 'ECONNREFUSED', Nov 01 09:51:44 volumio volumio[2941]: syscall: 'connect', Nov 01 09:51:44 volumio volumio[2941]: address: '127.0.0.1', Nov 01 09:51:44 volumio volumio[2941]: port: 9879, Nov 01 09:51:44 volumio volumio[2941]: response: undefined Nov 01 09:51:44 volumio volumio[2941]: } Nov 01 09:51:44 volumio volumio[2941]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 09:51:44 volumio sudo[4551]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 09:50' Nov 01 09:51:44 volumio sudo[4551]: 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"