Oct 26 01:46:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 412. Oct 26 01:46:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:00 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:00 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:00 volumio go-librespot[6461]: go-librespot daemon starting... Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="app state loaded" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" 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]" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" 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]" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=info msg="zeroconf server listening on port 38849" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="obtained new client token: AADKze7MHemTUn/k4cPlhk2Ifi3H0+C/CVksu3IGLZOWScW/zHS7zA9lfh19nioWv6CL1D6fvM4/dwmPs6P7h2rQC9xlGMlLdFEsDTDBklezze3Vo9jtIhUYIeP/Udpyo1M/T/rRvaoX/er9Udn9tqR0SXyZJ+3Q096hvswWlS8uwAKZmSNJw7buLUYxX6ssBa+VT9wp78hg9OxRlI0sl/4Smfc+jQS4XFKvIiAsMQqX9WAjxCDlwcI=" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="completed keyexchange" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=debug msg="completed challenge" Oct 26 01:46:00 volumio go-librespot[6462]: time="2025-10-26T01:46:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:03 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:03 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 413. Oct 26 01:46:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:03 volumio go-librespot[6483]: go-librespot daemon starting... Oct 26 01:46:03 volumio go-librespot[6484]: time="2025-10-26T01:46:03Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:03 volumio go-librespot[6484]: time="2025-10-26T01:46:03Z" level=debug msg="app state loaded" Oct 26 01:46:03 volumio go-librespot[6484]: time="2025-10-26T01:46:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" 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]" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" 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]" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" 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]" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=info msg="zeroconf server listening on port 45433" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=debug msg="obtained new client token: AAAfSInK5fZ8Me6STq5L2RTyOk/OjynTSQbuHV1C6dOOAUDgYnZtjrG+iIhvBUVYoiAmvu41Lji4Op5EyCceMZCcspoR2itN7Q1i2ytawM+URX/JaJ7INOpXE23QSyn+tPdhBtvjaf9vv3TbOvYH5U2SqG89sMzk2oC8dKQgd4ana65QJoATWCjiUkzNyNppHiWHjAfrnELyAbFnFosyA/ED4XnkcrTnLcHbXccxWx2W5vzjwZ9X" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=debug msg="completed keyexchange" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=debug msg="completed challenge" Oct 26 01:46:04 volumio go-librespot[6484]: time="2025-10-26T01:46:04Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:06 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:06 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 414. Oct 26 01:46:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:07 volumio go-librespot[6491]: go-librespot daemon starting... Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=debug msg="app state loaded" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46: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]" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46: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]" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46: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]" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=info msg="zeroconf server listening on port 37351" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=debug msg="obtained new client token: AACYgQMG1os3/TBtWZXhkTRbnuHC2x2T6cA7jFuag/AjGpJkDzA0rGY/Rs+UdiQu7o2QMV7L8gY21AqW3NYx7FIK+D50+qd4JgFCJsBvDzCUz5PVwXdSxPhDfe8rVzXhnsvgprXnteCoAy6pWGAmVU7WpTW5VwC6r/wVTLCdPtR+bOtu4Z9N6Yg1bGHFNMPnAQoBxYCyCFO6EtHU33E5J/PfGbRwR0608nwf43J52bQ/q5DpyY1fZUY=" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=debug msg="completed keyexchange" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=debug msg="completed challenge" Oct 26 01:46:07 volumio go-librespot[6492]: time="2025-10-26T01:46:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:08 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:46:09 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:09 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 415. Oct 26 01:46:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:10 volumio go-librespot[6500]: go-librespot daemon starting... Oct 26 01:46:10 volumio go-librespot[6501]: time="2025-10-26T01:46:10Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:10 volumio go-librespot[6501]: time="2025-10-26T01:46:10Z" level=debug msg="app state loaded" Oct 26 01:46:10 volumio go-librespot[6501]: time="2025-10-26T01:46:10Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" 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]" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" 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]" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" 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]" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=info msg="zeroconf server listening on port 35773" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=debug msg="obtained new client token: AACvCk4oQPmAMHaEDI4wmwJFVd1LvV+YqYpNDxEwBwptvhBSDaNjODg9iPTkQIL8C+dd/eXWiQk0oKagUXGopN9BrPjFjYRki+B5aW9dyXF63i5AoHUQpmqtsQ4yt2NPY/yweyp8pvP2ff28oNj08Vn0bS/tbLEm0s9tYhGR//Sx9s9Wey83Bc3fvgDfwHusEr83n2BOG5BEwcXoGNOZfup3I9kqG2WObHO5M1tMXL+gkmG1V+EX" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=debug msg="completed keyexchange" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=debug msg="completed challenge" Oct 26 01:46:11 volumio go-librespot[6501]: time="2025-10-26T01:46:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:12 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:12 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 416. Oct 26 01:46:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:14 volumio go-librespot[6523]: go-librespot daemon starting... Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="app state loaded" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=info msg="zeroconf server listening on port 33523" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="obtained new client token: AADTzYr0mXHK0HwPL96FCsf7dO5RzPOrPYG+XsVuoiJbTf+Qr+SbAcUPUnzwWYLaeI9LcHgO2RpM2QYZWdPfjiC+ex7G+WKi6IRFc3qGzkeb2THLeYWx8T4ShmmkpPaiuYZHXNMLQ+j/5bA3IBEI8oOHdNC5RWasB0Jq9AF0CaoHZHmkcwr9nacG+SqWdS/2lWKaqfoMwgD0uaNYFDbMpSq7R1DFGwqq5i9MJDJH+4FHKelFFFUUBTc=" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" 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" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="completed keyexchange" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=debug msg="completed challenge" Oct 26 01:46:14 volumio go-librespot[6524]: time="2025-10-26T01:46:14Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:15 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:15 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 417. Oct 26 01:46:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:17 volumio go-librespot[6531]: go-librespot daemon starting... Oct 26 01:46:17 volumio go-librespot[6532]: time="2025-10-26T01:46:17Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:17 volumio go-librespot[6532]: time="2025-10-26T01:46:17Z" level=debug msg="app state loaded" Oct 26 01:46:17 volumio go-librespot[6532]: time="2025-10-26T01:46:17Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" 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]" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" 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]" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=info msg="zeroconf server listening on port 39231" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=debug msg="obtained new client token: AABil9acF5PW7LOPwIlvPX1dk+vTVKItnBRNkW7RXe/vN0oZjYsUxFTNfyLZmwcMZ5XxZIn+E3Vld4MUBuvYwEv0augWvfWdSdbRNyU0BtpYLfJ42P5OpFDnlopPYj977efGqpzL29ieS1iy/L3XGcI2I0pJkE9niOcJvr02dYHJgxm/H2pkGVrSIpVKuEjraBocf+/Kc56yZPqS1axsfobIwl9ynqqVPRwr8r07N+3qSlfrVHi4" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=debug msg="completed keyexchange" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=debug msg="completed challenge" Oct 26 01:46:18 volumio go-librespot[6532]: time="2025-10-26T01:46:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:18 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:18 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:21 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:46:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 418. Oct 26 01:46:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:21 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:21 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:21 volumio go-librespot[6542]: go-librespot daemon starting... Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="app state loaded" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" 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]" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" 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]" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=info msg="zeroconf server listening on port 44503" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="obtained new client token: AABCP+u1+WUlg36sYKmaKnfeeWN8ywjfGJQo8DSGvviwgFjpuUq9bGsPDgviPp785Lcq0upZ1N4FqggJpd2EgZOlZios9Nrwh5g7A/JvMNhR6lsY1P2zhP4f2nXLOE8JxltrnT8IgjpT0PWIcN6omkRyqj2IoMqGNVgAd2szZXjc/QKVfP9xYqnuAs3yNcNM254rIJAw71Fq+zhQHtLfNUg9r1JmxOxBaQBhmlQl52tfONxBCB5Iwzo=" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="completed keyexchange" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=debug msg="completed challenge" Oct 26 01:46:21 volumio go-librespot[6543]: time="2025-10-26T01:46:21Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:24 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:24 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:24 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 419. Oct 26 01:46:24 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:24 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:24 volumio go-librespot[6564]: go-librespot daemon starting... Oct 26 01:46:24 volumio go-librespot[6565]: time="2025-10-26T01:46:24Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:24 volumio go-librespot[6565]: time="2025-10-26T01:46:24Z" level=debug msg="app state loaded" Oct 26 01:46:24 volumio go-librespot[6565]: time="2025-10-26T01:46:24Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" 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]" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" 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]" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=info msg="zeroconf server listening on port 34523" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=debug msg="obtained new client token: AAAMyQoGCt/RVZ+G+1pKCRgj8A9FlxyGbxCjzTUefX4R2rB4uNMxe0seGrlLMLtfdtznlC5IjUroDKXIYxBGXsiVdPSPhcPROIhaNyDP8iLCGtI1JspqNn7gFHRAw+27+tmeV+KiKrBELR2g3+FqX48aMIOdWV6gAWec647J9WKeHM8A9pqw4lCrZ7jSl9+IwvsCcc3oItpXWtNnnOOtgMGLNQZnSz5jo8v9YYAeEiT8zHcNd5qU" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=debug msg="completed keyexchange" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=debug msg="completed challenge" Oct 26 01:46:25 volumio go-librespot[6565]: time="2025-10-26T01:46:25Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:27 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:27 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 420. Oct 26 01:46:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:28 volumio go-librespot[6572]: go-librespot daemon starting... Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="app state loaded" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=info msg="zeroconf server listening on port 36093" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="obtained new client token: AADoDb0wnjJcCUx8CK67xGvKaPQNv2X0wOUkqSqnU113h7THK3DRaZcChtFkJ/Zaj4reTovMJPSMdcnsipvOqdtwEsdDJJi4ym51NUywXkJbynyE0QUbw2GAovSBM2JQYO916+r7Lu3G3ky/ltFAMRAjTsfTBMzILQYBZiQKiEOk8yzeGrCn9wfGWkSUcup9OwdD9zHgSv9V9YUXZq7uiu/JrUbI0mK0wz+F4RkfXjzzQ3POBgNexHY=" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="completed keyexchange" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=debug msg="completed challenge" Oct 26 01:46:28 volumio go-librespot[6573]: time="2025-10-26T01:46:28Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:28 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:46:30 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:30 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 421. Oct 26 01:46:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:31 volumio go-librespot[6594]: go-librespot daemon starting... Oct 26 01:46:31 volumio go-librespot[6595]: time="2025-10-26T01:46:31Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:31 volumio go-librespot[6595]: time="2025-10-26T01:46:31Z" level=debug msg="app state loaded" Oct 26 01:46:31 volumio go-librespot[6595]: time="2025-10-26T01:46:31Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" 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]" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" 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]" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=info msg="zeroconf server listening on port 39207" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=debug msg="obtained new client token: AABEZHXtmWm8Oguwf7hf7swW5zijWGioSdTJpnWNM07YCXJ9St6gxl1VMkcIAplV/c6hAqDC0idhZ12m0mC500XHzGpWaqRcVQ7bjjpP6RxTIJhzjqu9E00StQAXibn9ycLwpB0xpJkavv3z+6tft9HbYqN9+JvnR/xI8+70XEAf91SVkJs0GIrIhM/qZCuHPpK+/MLL5mCBem98/68bv1xcRuX87Tyj/yf782ClLHApOdByu3zP" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=debug msg="completed keyexchange" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=debug msg="completed challenge" Oct 26 01:46:32 volumio go-librespot[6595]: time="2025-10-26T01:46:32Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:33 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:33 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 422. Oct 26 01:46:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:35 volumio go-librespot[6603]: go-librespot daemon starting... Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=debug msg="app state loaded" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" 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]" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" 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]" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=info msg="zeroconf server listening on port 41391" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=debug msg="obtained new client token: AACmKxd1ynb3/wBfNIfb6wUcI6Rx5L1SjEmI/gmpZlZ3hIA1CQZQDsyonF0Pk0zrInvdfB3XjjFzAL/oLKCIfYLIa+Sz4eN/RrbFqXbzHSremeRuuZMRkhzr/MSGwxEs9o5VTQ20xzxN2oVm5Otu63cPd9X7PPKN70ChSk5e7niQNUQVY2r1e79qINqlR8xoApqBBe9pGjHlvz358wgXqQA8f5vxHO0YwZYiHlHePFtIk3d4RvxggTM=" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=debug msg="completed keyexchange" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=debug msg="completed challenge" Oct 26 01:46:35 volumio go-librespot[6604]: time="2025-10-26T01:46:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:36 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:36 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:37 volumio nmbd[1166]: [2025/10/26 01:46:37.771485, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Oct 26 01:46:37 volumio nmbd[1166]: Packet send failed to 192.168.1.255(138) ERRNO=Network is unreachable Oct 26 01:46:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 423. Oct 26 01:46:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:38 volumio go-librespot[6614]: go-librespot daemon starting... Oct 26 01:46:38 volumio go-librespot[6615]: time="2025-10-26T01:46:38Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:38 volumio go-librespot[6615]: time="2025-10-26T01:46:38Z" level=debug msg="app state loaded" Oct 26 01:46:38 volumio go-librespot[6615]: time="2025-10-26T01:46:38Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:38 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" 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]" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" 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]" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" 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]" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=info msg="zeroconf server listening on port 43857" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=debug msg="obtained new client token: AAAhp5gaRz35k8zIDI1bRSu7r3lr97ePxY/4Rxt/ARyEju8ztqRKsXCXK1pRlmr/559ELMpblRlPtGmOpRTdlGrIQycjp5LposzuKLFqV61vv3nSCgPBSPBRvrtNnTcLOhWPZv927E0LdwZO+jtq4nYeEhyoFCDyG8sKXv4cNmkhXjGPpgaMLAno9FM13EbqcZqqlHjz3GyqNOS0alxzwBYx6OIeVK0vrSaXuDJTMHwRaUTS9XIZ" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=debug msg="completed keyexchange" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=debug msg="completed challenge" Oct 26 01:46:39 volumio go-librespot[6615]: time="2025-10-26T01:46:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:39 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:39 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 424. Oct 26 01:46:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:42 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:42 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:42 volumio go-librespot[6636]: go-librespot daemon starting... Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="app state loaded" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" 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]" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" 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]" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=info msg="zeroconf server listening on port 45987" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="obtained new client token: AADME+CEwKHSzib+HKBZl40gcPpRP94YPwRqPQ5JBJmnBtkMawKEJJfjJ/zHgT4cHrxeYXfza7DGzdE+a8X1gMP25MtawTIgvz3k501aq6Ed8U0CcEb4v9GX+8O0X9nwi/DIUQYi5rcraevrTNMb7Rzm/Jd1uukr67avfBZvhbJbX7PljB652P65XfZiaNsBy4xOz0wD6A49D2rFZ7yuqp1kibEU7BDnRd0eIgxtdKxLN41MXa+YjsM=" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="completed keyexchange" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=debug msg="completed challenge" Oct 26 01:46:42 volumio go-librespot[6637]: time="2025-10-26T01:46:42Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:42 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:42 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:45 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:45 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:45 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 425. Oct 26 01:46:45 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:45 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:45 volumio go-librespot[6644]: go-librespot daemon starting... Oct 26 01:46:45 volumio go-librespot[6645]: time="2025-10-26T01:46:45Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:45 volumio go-librespot[6645]: time="2025-10-26T01:46:45Z" level=debug msg="app state loaded" Oct 26 01:46:45 volumio go-librespot[6645]: time="2025-10-26T01:46:45Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" 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]" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" 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]" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=info msg="zeroconf server listening on port 37831" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=debug msg="obtained new client token: AAAzF4gy4LhW4NUjn4qX/GZWe0jXpw5uFg0nU8sXLBXxvp7TQwZJ5AeE9M3buJRBXiS4Df/+47XIlCMW1Q3Zfos9i/DsUUZc8WTha8HxB5CHupkMjRZmCPuw46v3feGuboAZH8/fnVW3+3+NAnkJMaMScD3MVOrzSC/Mdu+ch7vBTKycreN//2jw4Q4GlQwaOWjhsTTleW9Oz6FqocvfuS0JElQe9OVODuPIVervC5diyM2VzrSf" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=debug msg="completed keyexchange" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=debug msg="completed challenge" Oct 26 01:46:46 volumio go-librespot[6645]: time="2025-10-26T01:46:46Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:48 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:48 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 426. Oct 26 01:46:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:49 volumio go-librespot[6652]: go-librespot daemon starting... Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="app state loaded" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=info msg="zeroconf server listening on port 34693" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="obtained new client token: AACPVjxSV4BSuREH2BOuzA8oHA1Et/m6moR3w4kCXuV+8Pahgjc29a6I5bDV/VAtIadfMjLx9Xf4FwL9ybbwnH5lMuN3uCTyp2iIQtFl2fubIjtBFWF0hFX5hKyjvQP3gMkPNSpqlDrsW3TJSo0cMKa5Zv1bN2n4AvOJoLC7SHVOAUFMFwUKMHqr07cRmYr3vTpTy2O6jJD1RllhJATSXnkpE/1VxWUJSuEMUfOt77G7PE/PnQaD0RA=" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="completed keyexchange" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=debug msg="completed challenge" Oct 26 01:46:49 volumio go-librespot[6653]: time="2025-10-26T01:46:49Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:51 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:51 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:51 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:46:52 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 427. Oct 26 01:46:52 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:52 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:52 volumio go-librespot[6675]: go-librespot daemon starting... Oct 26 01:46:52 volumio go-librespot[6676]: time="2025-10-26T01:46:52Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:52 volumio go-librespot[6676]: time="2025-10-26T01:46:52Z" level=debug msg="app state loaded" Oct 26 01:46:52 volumio go-librespot[6676]: time="2025-10-26T01:46:52Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" 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]" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" 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]" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" 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]" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=info msg="zeroconf server listening on port 37119" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=debug msg="obtained new client token: AAC+ShRU2Dkqk/G/+iMxxifuAcf+IzDr+GbZiYMBNFjjgAGgJOjP7hgbOvObx7mbOPdLmzkqFG9fZKbbOuomTb1qSt2HugZXpWA0RQJX4WlyZdPryff5xDNDw3z2Pw9MotmZL4hCi3+o2AaC8IeF6BEZK8gHM9OrM9lblH+OonBiD/JmpJMisl0AhmsTLIjEBVxllc3/LecVEBpbMPAP9Jw3sCKdloSq/nYeq1HspQRG7/M2JNtP" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=debug msg="completed keyexchange" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=debug msg="completed challenge" Oct 26 01:46:53 volumio go-librespot[6676]: time="2025-10-26T01:46:53Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:54 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:54 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 428. Oct 26 01:46:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:56 volumio go-librespot[6683]: go-librespot daemon starting... Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=debug msg="app state loaded" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" 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]" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" 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]" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=info msg="zeroconf server listening on port 34301" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=debug msg="obtained new client token: AAB8x2kX0TzEKDuhatGMCXofgADiVULRMXg6zFecXmfMe0oyt8wyst8q7xr2iYjHfuFUo33ih/J4/r5kTqkm+8OXKiadvrYtEfa/PrVeiGMBet66wd1UE/HbQ6wT89hzAHfmsnIu3x+vedqosMgKtGLoKf++M85X8jczzG62AarXmXJ0/IpiS4WlwLR52FXnzACuHKwNAb2kKUT8G7n3ubfkJ2MPeBgIo0PmePJECeDYmFPVulW4IQY=" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=debug msg="completed keyexchange" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=debug msg="completed challenge" Oct 26 01:46:56 volumio go-librespot[6684]: time="2025-10-26T01:46:56Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:46:56 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:46:56 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:46:57 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:46:57 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:46:59 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 429. Oct 26 01:46:59 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:59 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:46:59 volumio go-librespot[6696]: go-librespot daemon starting... Oct 26 01:46:59 volumio go-librespot[6697]: time="2025-10-26T01:46:59Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:46:59 volumio go-librespot[6697]: time="2025-10-26T01:46:59Z" level=debug msg="app state loaded" Oct 26 01:46:59 volumio go-librespot[6697]: time="2025-10-26T01:46:59Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" 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]" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" 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]" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=info msg="zeroconf server listening on port 37779" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=debug msg="obtained new client token: AADcpWYUKKVeqImkW4wjrN0dCHcUDPijoE3BYfp+HARDBUrF6VSdKprsf1ROhQWIR4TDVHU5kbRG4UuiQJL5LEl1+OT+UVlZ/vbPyoXKtcKRwcoDf+F8/ErXGFPC6JzPDYYjdl52srNkRTBY481/ZKgC/EMxf0eWYkJ6d4fsqVXq4feX4ry2SvTL3wIgvjaY/af9mUZi0XNgp+7vNrCyxqU5ow0nUMrSI94Zpa5OKfEIhwETpjr7" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" 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" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=debug msg="completed keyexchange" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=debug msg="completed challenge" Oct 26 01:47:00 volumio go-librespot[6697]: time="2025-10-26T01:47:00Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:47:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:47:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:47:00 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:47:00 volumio volumio[5970]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:47:00 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:47:03 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 430. Oct 26 01:47:03 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:47:03 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 26 01:47:03 volumio go-librespot[6718]: go-librespot daemon starting... Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=info msg="running go-librespot 0.4.0" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="app state loaded" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 26 01:47:03 volumio volumio[5970]: info: Initializing connection to go-librespot Websocket Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="new websocket client" Oct 26 01:47:03 volumio volumio[5970]: info: Connection to go-librespot Websocket established Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" 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]" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" 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]" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=info msg="zeroconf server listening on port 45739" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="obtained new client token: AAC+cF4WYP3CzHTNGHoVnU8p4kg2+0t8+qfpVEENh0MgbEWUMK6W8GKyDj2um5xZfYfSL0GCkqG0CCkfWeFivpdRW9VhQPvdVKAAYWndjU03Ar8CO6/vowUeA/iMGMl1YlRQU1FMYdU8XmhKN9VblBFiQyogvpiu8LHrqjlUoA78nygHHZGu/tJhG3ceNVEOvpZhHws9rH+eoBxiqWk6t+Sxa0KezGnKAq2q3McNRxFfjECGjVJD8Jw=" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="completed keyexchange" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=debug msg="completed challenge" Oct 26 01:47:03 volumio go-librespot[6719]: time="2025-10-26T01:47:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 26 01:47:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 26 01:47:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 26 01:47:03 volumio volumio[5970]: info: Connection to go-librespot Websocket closed Oct 26 01:47:06 volumio kernel: nfs: server 192.168.1.3 not responding, timed out Oct 26 01:47:06 volumio volumio[5970]: info: Getting Spotify volume Oct 26 01:47:06 volumio volumio[5970]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 01:47:06 volumio volumio[5970]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 26 01:47:06 volumio volumio[5970]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 26 01:47:06 volumio volumio[5970]: errno: -111, Oct 26 01:47:06 volumio volumio[5970]: code: 'ECONNREFUSED', Oct 26 01:47:06 volumio volumio[5970]: syscall: 'connect', Oct 26 01:47:06 volumio volumio[5970]: address: '127.0.0.1', Oct 26 01:47:06 volumio volumio[5970]: port: 9879, Oct 26 01:47:06 volumio volumio[5970]: response: undefined Oct 26 01:47:06 volumio volumio[5970]: } Oct 26 01:47:06 volumio volumio[5970]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 01:47:06 volumio sudo[6740]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-26 01:46' Oct 26 01:47:06 volumio sudo[6740]: 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"