Oct 27 14:06:00 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:00 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 616.
Oct 27 14:06:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:00 volumio go-librespot[4002]: go-librespot daemon starting...
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=debug msg="app state loaded"
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" 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 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" 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 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" 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 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=info msg="zeroconf server listening on port 34971"
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=debug msg="obtained new client token: AABHpA3sU7vPeOrBOdlMnPWljg0o4iT7RmDX3BQZ3/aoAeInw0T4A78Tkw19bDgiH8SQNiy03fD8KrTVlEVQrXZD0s93+A3PQkKDyhzqGlHeOxzNqxx4M/HwbyFlKRNzLvjZbNzgmiCcFvHt+CzzY8FZai1u95RB7garyOnvJD0+XPVEZRsC2S1vaEZsjTUh3bP8SX73xzt/VApVi+mHWRTI7/uGzCgoTQKAdQivzrtIkA+QvRxJdwA="
Oct 27 14:06:00 volumio go-librespot[4003]: time="2025-10-27T14:06:00Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:01 volumio go-librespot[4003]: time="2025-10-27T14:06:01Z" level=debug msg="completed keyexchange"
Oct 27 14:06:01 volumio go-librespot[4003]: time="2025-10-27T14:06:01Z" level=debug msg="completed challenge"
Oct 27 14:06:01 volumio go-librespot[4003]: time="2025-10-27T14:06:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:03 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:03 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 617.
Oct 27 14:06:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:04 volumio go-librespot[4010]: go-librespot daemon starting...
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=debug msg="app state loaded"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" 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 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" 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 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=info msg="zeroconf server listening on port 44169"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=debug msg="obtained new client token: AAAlwI+nfxOFxmolJVMYpn7H/0XHbilpxNqmaPep56vwBdNdIbK7mTDnA8G4HFuqpGZz6zt3do95yC/ysjEW3+tvENhlGg8QYxD/OR3opPuXuY5A1aAc2CrZPPeknwnR05ogYQCHTK0BOVO6Nou9vcJNhDRnIkOHTvuH0B0cXFwdieS5LdTdgVZmYit80ao5bIo+eP8XQjuT1G0738rSG8ZkCBLIb1IzKy2ELg/t3w73X36qTMI1Hhk="
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=debug msg="completed keyexchange"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06:04Z" level=debug msg="completed challenge"
Oct 27 14:06:04 volumio go-librespot[4013]: time="2025-10-27T14:06: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 27 14:06:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:06 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:06 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 618.
Oct 27 14:06:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:07 volumio go-librespot[4026]: go-librespot daemon starting...
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" level=debug msg="app state loaded"
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06: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 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06: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 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06: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 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" level=info msg="zeroconf server listening on port 46153"
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" level=debug msg="obtained new client token: AACYH39nWGd0YDTkAsebvwMAaYQjyov5xn4V+4MQAif9V8TUV6KjGrLaomjU7ytIhAH9edPtkGTzLz9XQt85ntFNGq0qZqby4Y0akk4Ru00Kh9gUoIymTrQGvReunQTdv5rViqgx3SK1P907MKmhzv6JyAmCPm4fnZe8E8zqFMi+NJ71ojy9ru1BaCFsrUl62SwJvbAAfOI0CbaA0Zy7xcoX6mhkuP/WRUL9itlzEgiFRvcy1zQAPnI="
Oct 27 14:06:07 volumio go-librespot[4027]: time="2025-10-27T14:06:07Z" 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 27 14:06:08 volumio go-librespot[4027]: time="2025-10-27T14:06:08Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.65.9:443: connect: connection refused"
Oct 27 14:06:08 volumio go-librespot[4027]: time="2025-10-27T14:06:08Z" level=debug msg="connected to ap-gew1.spotify.com:80"
Oct 27 14:06:08 volumio go-librespot[4027]: time="2025-10-27T14:06:08Z" level=debug msg="completed keyexchange"
Oct 27 14:06:08 volumio go-librespot[4027]: time="2025-10-27T14:06:08Z" level=debug msg="completed challenge"
Oct 27 14:06:08 volumio go-librespot[4027]: time="2025-10-27T14:06:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:09 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:09 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:11 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 619.
Oct 27 14:06:11 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:11 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:11 volumio go-librespot[4048]: go-librespot daemon starting...
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=debug msg="app state loaded"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" 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 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" 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 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=info msg="zeroconf server listening on port 46707"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=debug msg="obtained new client token: AAA7nLDr0uqAefye8N3r0HQf5A+ozXMF+dXgMwRI5OkNk3dJD0McFcY096GIGh8CqQrNum10a8GYTp2/UeecUd6qBjTvrHRl+Dwgkr6aVhsqnVeAtrJRE514mGmDVvkoQr4Z+LsrEhbI0Sv+d8psA7CaAizNKpKmbEzKblvrzy4y3NAhZ4NiGTCq1lpzhRKJkFWTIhoKFp4uU6Vz9lxwI8946NUzJs2Rne+yFv7vUl9hdPYJ7oR08W8="
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" 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 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=debug msg="connected to ap-gew1.spotify.com:443"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=debug msg="completed keyexchange"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06:11Z" level=debug msg="completed challenge"
Oct 27 14:06:11 volumio go-librespot[4049]: time="2025-10-27T14:06: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 27 14:06:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:12 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:12 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 620.
Oct 27 14:06:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:14 volumio go-librespot[4056]: go-librespot daemon starting...
Oct 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06:14Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06:14Z" level=debug msg="app state loaded"
Oct 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06:14Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06: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 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06: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 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06: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 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06:14Z" level=info msg="zeroconf server listening on port 33981"
Oct 27 14:06:14 volumio go-librespot[4057]: time="2025-10-27T14:06:14Z" level=debug msg="obtained new client token: AABTgWA/tkSivjQq/c2tyPFbKUoPzHJp0tK+PMrS6qRk+Tr7+0oEx3x5rfG98WkHdJIJe4Pg0dk+K75R15NhE4Eg1AbLFMLzrz1cGhS1DWHFxNygyRfdDdIHKsF1gTtUuv1aBbKqrIKOhQ/uhW6J0OC+kh6Ax0Ml7Bk5Eau30hBk7Tpf7dD8hZLdgZmjK2n5waQjWo6McZFCl2hVdyxOIo8BjxKlQxUyaVq113cnpzkKmKd26G0fnJs="
Oct 27 14:06:15 volumio go-librespot[4057]: time="2025-10-27T14:06:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:15 volumio go-librespot[4057]: time="2025-10-27T14:06:15Z" level=debug msg="completed keyexchange"
Oct 27 14:06:15 volumio go-librespot[4057]: time="2025-10-27T14:06:15Z" level=debug msg="completed challenge"
Oct 27 14:06:15 volumio go-librespot[4057]: time="2025-10-27T14:06:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:15 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:15 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 621.
Oct 27 14:06:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:18 volumio go-librespot[4067]: go-librespot daemon starting...
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="app state loaded"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=info msg="zeroconf server listening on port 33719"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="obtained new client token: AABmLP80yNB0XhzVJ8Nf7K+GVnrpFeTMDRyJ2GDK4fESH53jngjQQtAyflEN9UCWH34ivo1re4H/kZE4cZhD6rBwDJCD0ul7hSV4VpyYb14pLLiVjae8IZwreySwPdorAI+W5pq6Eg0IMJh/Q2f0RDWc5HM6ysXI4MMtEIY/YzSQk2bxYhvXWhA52+20Ov+op4Nu3l2hBFlc2bhz0OIzI39SpsTpPRxNTfO+B5RB+f0ZFkYFWxatYjo="
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="completed keyexchange"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06:18Z" level=debug msg="completed challenge"
Oct 27 14:06:18 volumio go-librespot[4068]: time="2025-10-27T14:06: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 27 14:06:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:18 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:18 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:21 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:21 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 622.
Oct 27 14:06:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:21 volumio go-librespot[4095]: go-librespot daemon starting...
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" level=debug msg="app state loaded"
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06: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-gew4.spotify.com:80]"
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" 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 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" 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 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" level=info msg="zeroconf server listening on port 36329"
Oct 27 14:06:21 volumio go-librespot[4096]: time="2025-10-27T14:06:21Z" level=debug msg="obtained new client token: AADssRNc6q6pKbJpMO/O4haekLWIupkIXHdvxrHk8q8ZMnYFrp33dSMUyIZDbuw9BkmgPeFYQYkVfnybhgVji9hYLigbIGMIEZiZ3RqJXp1qlQ+ztVJ3c9lYL5oL6UzhKxqv4k3Goha2IddlSsqagEOEpHqYoHrBqE8IaHlQjmCFT00gny5ajzARCVXj0YkS8kuo9gXb5tbaDPm4C1EClrN8o7bY0d/bamVOImT3pqJDfsuUBo3Bi1E="
Oct 27 14:06:22 volumio go-librespot[4096]: time="2025-10-27T14:06:22Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:22 volumio go-librespot[4096]: time="2025-10-27T14:06:22Z" level=debug msg="completed keyexchange"
Oct 27 14:06:22 volumio go-librespot[4096]: time="2025-10-27T14:06:22Z" level=debug msg="completed challenge"
Oct 27 14:06:22 volumio go-librespot[4096]: time="2025-10-27T14:06:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:24 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:24 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 623.
Oct 27 14:06:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:25 volumio go-librespot[4103]: go-librespot daemon starting...
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=debug msg="app state loaded"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06: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 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06: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 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06: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 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=info msg="zeroconf server listening on port 44487"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=debug msg="obtained new client token: AACHwts8t541mTF45BRd6ZvkGvL0Uplzv631scp1vP/JtTcQ4ToXy9Qp9G/DbedvJ50eO6iGcCanxywJNuC+9JAbd0NASv/EDxz9G9OJdmU1mDFzcGn4JgWgO0VwWq/XbSmcoST5pPBrJVyL2SC84pqySjunuRFzPZNxtZr4V/FYxJysdDGwTeLUa4Ry+M/I8p7GtQleuhcvPThn4tM/rbVchlsPf1peEC9fcUVkAE5gluKTFO+F5cY="
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=debug msg="completed keyexchange"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06:25Z" level=debug msg="completed challenge"
Oct 27 14:06:25 volumio go-librespot[4104]: time="2025-10-27T14:06: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 27 14:06:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:27 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:27 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 624.
Oct 27 14:06:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:28 volumio go-librespot[4126]: go-librespot daemon starting...
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06:28Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06:28Z" level=debug msg="app state loaded"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06:28Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06: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]"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06: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]"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06: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]"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06:28Z" level=info msg="zeroconf server listening on port 41025"
Oct 27 14:06:28 volumio go-librespot[4127]: time="2025-10-27T14:06:28Z" level=debug msg="obtained new client token: AABGOaINn0vJ+FQ1JnrlTANyrr0hpWTgpb/J/QocLt1A1Z41Da3Syq38F20k9yOwrBmhYkx3zfWJQHtAChKW7IpXjpLuRcnj6wy8QE4xX7Bp32UwsCLkBpujBzfxdK0f2BYSeimjxeTl1QEiGzYlb9kzLVYZ7LaHwnW0e5ErWAamxna/SdRVXr4GIwVPTxfaHfqTjSyyqquR9BKKZTXLY/4m5K58EkypjUb8DzFop383IMhccB4N5A8="
Oct 27 14:06:29 volumio go-librespot[4127]: time="2025-10-27T14:06:29Z" 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 27 14:06:29 volumio go-librespot[4127]: time="2025-10-27T14:06:29Z" level=debug msg="connected to ap-gew1.spotify.com:443"
Oct 27 14:06:29 volumio go-librespot[4127]: time="2025-10-27T14:06:29Z" level=debug msg="completed keyexchange"
Oct 27 14:06:29 volumio go-librespot[4127]: time="2025-10-27T14:06:29Z" level=debug msg="completed challenge"
Oct 27 14:06:29 volumio go-librespot[4127]: time="2025-10-27T14:06:29Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:30 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:30 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 625.
Oct 27 14:06:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:32 volumio go-librespot[4135]: go-librespot daemon starting...
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=debug msg="app state loaded"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" 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 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" 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 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" 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 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=info msg="zeroconf server listening on port 36427"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=debug msg="obtained new client token: AABRgVN02hA7gpOECyrJMohJG2vBkl2kfIyItRwEnp3P2xbOylD6+xbBd66Z/z2v2+4qi1suxdDa2PvVYNkV910do1hGygxOevbMAZrwxfRS9Q5q7/4jYX/hKPBukOHTPcAv2rJ/uuP6pmfY8Uu4NGX4ki9Xqv1+4zCOZ4pfuG2QsJ4ZwNPdg3Dahk/ub8R9uvFkjyV7IB/tRSQZWVxN3qv/mU7JZ3nHiVz5DGrXsYlHoHUJktPdcww="
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=debug msg="completed keyexchange"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06:32Z" level=debug msg="completed challenge"
Oct 27 14:06:32 volumio go-librespot[4136]: time="2025-10-27T14:06: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 27 14:06:32 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:32 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:33 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:33 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 626.
Oct 27 14:06:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:35 volumio go-librespot[4152]: go-librespot daemon starting...
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06:35Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06:35Z" level=debug msg="app state loaded"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06:35Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06: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]"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06: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]"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06: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]"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06:35Z" level=info msg="zeroconf server listening on port 40685"
Oct 27 14:06:35 volumio go-librespot[4153]: time="2025-10-27T14:06:35Z" level=debug msg="obtained new client token: AADDNcVGihdbHGU4twxKKH53Hq499ULwyPtFZzHBZiY7WF8smw4i/7e2MhVj5oWeJ6Ug1YgxNTt7nFsW4kyydhg4ly1reOcCN5alg9En4ahJbI/f1Q19j8iS9P/QNSGeLxHym0vl+iMZiRdGhqLDwfW9KmaBhqhGu2BqUhiG5WYI6svSRn+V+dNOgx72n553jQm6790UpWus1IroAbIT+SQQ97PhdWQQ1v8TeVv5ECjioMTcKsSw3cM="
Oct 27 14:06:36 volumio go-librespot[4153]: time="2025-10-27T14:06:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:36 volumio go-librespot[4153]: time="2025-10-27T14:06:36Z" level=debug msg="completed keyexchange"
Oct 27 14:06:36 volumio go-librespot[4153]: time="2025-10-27T14:06:36Z" level=debug msg="completed challenge"
Oct 27 14:06:36 volumio go-librespot[4153]: time="2025-10-27T14:06:36Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:36 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:36 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 627.
Oct 27 14:06:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:39 volumio go-librespot[4174]: go-librespot daemon starting...
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="app state loaded"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=info msg="zeroconf server listening on port 44543"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="obtained new client token: AABHGAXe3ehtulsbNFwh3PD02yxmQEr71eOgJ1UMQebRpczPYNYJFVAP0elYZJh1jMk1dAFj0BjBRllCqCHJ5VRu+PykM8SJ4fqYsexlH8PgxKed8tUxm8dlb0J1VkWL0kCfHlKNhhjG34BjgxCSPWu7DyygH7r+RKBzy0jQezUUP354JFFRBy+7XmUV9tQAvozBAwm70ImaVkJGm7qzgxr9IRs8KKTWMWvUcuNhRKE+KGj7xpWXuo4="
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="completed keyexchange"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06:39Z" level=debug msg="completed challenge"
Oct 27 14:06:39 volumio go-librespot[4175]: time="2025-10-27T14:06: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 27 14:06:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:39 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:39 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:42 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:42 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 628.
Oct 27 14:06:42 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:42 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:42 volumio go-librespot[4182]: go-librespot daemon starting...
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" level=debug msg="app state loaded"
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06: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-gew4.spotify.com:80]"
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" 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 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" 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 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" level=info msg="zeroconf server listening on port 33463"
Oct 27 14:06:42 volumio go-librespot[4183]: time="2025-10-27T14:06:42Z" level=debug msg="obtained new client token: AAB/US2VZtrm+jBB5nAwkgZb4WaSJx3JToWuJPjUgSEXn3mQZUoTUxscwHdgnG8VT85XLqHGWBnBiHKkyaiX4RN7Hwo3e4PNMiG2HxIipUhpElgI2OP6dD+7dUz65ktFo5gjCsY+7ziHeNRt7rykY48UES/p2kSubOw72rsw61GVEDnwiEAVTi5EzJU+zSd1oJvg60MW5QGcIl1cXhnviTtqwtjWQ0/YWwPwEVMcprrcQIn+lkjAVkE="
Oct 27 14:06:43 volumio go-librespot[4183]: time="2025-10-27T14:06:43Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:43 volumio go-librespot[4183]: time="2025-10-27T14:06:43Z" level=debug msg="completed keyexchange"
Oct 27 14:06:43 volumio go-librespot[4183]: time="2025-10-27T14:06:43Z" level=debug msg="completed challenge"
Oct 27 14:06:43 volumio go-librespot[4183]: time="2025-10-27T14:06:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:45 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:45 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 629.
Oct 27 14:06:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:46 volumio go-librespot[4191]: go-librespot daemon starting...
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=debug msg="app state loaded"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" 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 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" 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 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" 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 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=info msg="zeroconf server listening on port 40125"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=debug msg="obtained new client token: AACgTLaaZoib8p4IXDG6vECqFrOPxTfKKIruON4a5tNV02Xm+IYCgsCFOR2hD8V3qarXxEErA4ZRsmVyxEcGS1MGHzKw9pFYhzlBLg6Qy51c+tVUDyw4GNg8eah/P9nd9j+qkbsMMSGk57NUYVZyDwUMxwGjk4mphDYpnutTh8+FN+fRSEnktxJ4nuBSzXzC4juI6EUWuSuWiGPj0EYBlgUj67klhiBDxO19xZBTFnN0lkcXy1tb0MQ="
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=debug msg="completed keyexchange"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06:46Z" level=debug msg="completed challenge"
Oct 27 14:06:46 volumio go-librespot[4192]: time="2025-10-27T14:06: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 27 14:06:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:48 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:48 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 630.
Oct 27 14:06:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:49 volumio go-librespot[4214]: go-librespot daemon starting...
Oct 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" level=debug msg="app state loaded"
Oct 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" 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 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" 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 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" 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 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" level=info msg="zeroconf server listening on port 44079"
Oct 27 14:06:49 volumio go-librespot[4215]: time="2025-10-27T14:06:49Z" level=debug msg="obtained new client token: AAAKwAWCyqQw/jFGY7Rq52bke9LBbg9c3UzxEVpa4Nka5eWYJOeZ44rOnSEEi1PCmQlL2+dRc3gBE0/Cq0hbZpvORksLFTc0SPnPX2ALltQHK9n5kh/XHx/QK9LjE4g/R23ehpjriLHeCpaI9vfkvJT74p5UeIbjO7MgsSekm2qlOhx7VO4JLc+N7XOA8zyHLBuKDNrd4O199t4SG6pe40/9Jq/FIFlOtfMxaVDVCk3yDI1DuOw2Lzw="
Oct 27 14:06:50 volumio go-librespot[4215]: time="2025-10-27T14:06:50Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:50 volumio go-librespot[4215]: time="2025-10-27T14:06:50Z" level=debug msg="completed keyexchange"
Oct 27 14:06:50 volumio go-librespot[4215]: time="2025-10-27T14:06:50Z" level=debug msg="completed challenge"
Oct 27 14:06:50 volumio go-librespot[4215]: time="2025-10-27T14:06:50Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:51 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:51 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 631.
Oct 27 14:06:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:53 volumio go-librespot[4229]: go-librespot daemon starting...
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=debug msg="app state loaded"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" 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 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" 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 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=info msg="zeroconf server listening on port 38675"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=debug msg="obtained new client token: AABahVYN0ki7MLxA1TnHaEUM3cQFRLXh2r5CYPI7efMc4CrVmcedDDMiJDsZ7/tEx4F80OU46L/GAmaHlN0ZgHOzOaHba7XOZJqCHZwBVn+Re8h2RaVtGraW2na/HRjJAMbTnBT1NFPpDNXCiSRecL9V33cQ3V4ZH5UYTqt/ss2lFbUyEZ6gJGa8xrdurkVgPAvH3sQL6bvlV4sm3UnUvm10adY2bfMR/4MJVuSkd0Bh592eYeOEJ4g="
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=debug msg="completed keyexchange"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06:53Z" level=debug msg="completed challenge"
Oct 27 14:06:53 volumio go-librespot[4230]: time="2025-10-27T14:06: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 27 14:06:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:54 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:54 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:06:56 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 632.
Oct 27 14:06:56 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:56 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:06:56 volumio go-librespot[4240]: go-librespot daemon starting...
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=debug msg="app state loaded"
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" 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 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" 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 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" 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 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=info msg="zeroconf server listening on port 44195"
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=debug msg="obtained new client token: AAD5seN//oczifAabZzuZnGXqI/AEWqlFXTYv0yQEl5RNxFDiLZAKyIBoyAlO7Wq8SIIS7cQbuEoeTHX9cSw3q+gLtYybAfEqkVsDUwRwkQYvA8KaCCGMI2waqhbNJM6OCqpJVIcPDpcIwcwxJzCJRzE/LQglAKO0+SU6+beUVwkbfKQNuteF7YDUB5dOlbbT+PQ8OLdNj7kb76ciepXQmZ1buNjRlbLDtTTAX2GMW+UX+IyUbI6ZOY="
Oct 27 14:06:56 volumio go-librespot[4241]: time="2025-10-27T14:06:56Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:06:57 volumio go-librespot[4241]: time="2025-10-27T14:06:57Z" level=debug msg="completed keyexchange"
Oct 27 14:06:57 volumio go-librespot[4241]: time="2025-10-27T14:06:57Z" level=debug msg="completed challenge"
Oct 27 14:06:57 volumio go-librespot[4241]: time="2025-10-27T14:06:57Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:06:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:06:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:06:57 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:06:57 volumio volumio[3124]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Oct 27 14:07:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 633.
Oct 27 14:07:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:07:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Oct 27 14:07:00 volumio go-librespot[4262]: go-librespot daemon starting...
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=info msg="running go-librespot 0.4.0"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=debug msg="app state loaded"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=info msg="api server listening on 127.0.0.1:9879"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=info msg="zeroconf server listening on port 36195"
Oct 27 14:07:00 volumio volumio[3124]: info: Initializing connection to go-librespot Websocket
Oct 27 14:07:00 volumio go-librespot[4263]: time="2025-10-27T14:07:00Z" level=debug msg="new websocket client"
Oct 27 14:07:00 volumio volumio[3124]: info: Connection to go-librespot Websocket established
Oct 27 14:07:03 volumio volumio[3124]: info: Getting Spotify volume
Oct 27 14:07:03 volumio volumio[3124]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Oct 27 14:07:03 volumio volumio[3124]: info: CoreCommandRouter::volumioGetState
Oct 27 14:07:03 volumio volumio[3124]: info: CorePlayQueue::getTrack 0
Oct 27 14:07:03 volumio volumio[3124]: SPOTIFY: RECEIVED VOLUMIO VOLUME 33
Oct 27 14:07:03 volumio volumio[3124]: SPOTIFY: SPOTIFY VOLUME undefined
Oct 27 14:07:03 volumio volumio[3124]: SPOTIFY: VOLUMIO VOLUME 33
Oct 27 14:07:03 volumio volumio[3124]: info: Aligning Spotify Volume to Volumio Volume
Oct 27 14:07:03 volumio volumio[3124]: info: CoreCommandRouter::volumioGetState
Oct 27 14:07:03 volumio volumio[3124]: info: CorePlayQueue::getTrack 0
Oct 27 14:07:03 volumio volumio[3124]: info: Setting Spotify Volume from Volumio: 33
Oct 27 14:07:05 volumio go-librespot[4263]: time="2025-10-27T14:07:05Z" level=debug msg="obtained new client token: AAAA2Hj3mUpXF8SOue+3Q2/4/W6IUZUdWetHC1vYewdx/YH055/+h54DoKQmdIZ0SRShtU9jp5jk8Bp6cETcGqX/+rTSllVEMtkKdhRxobZCjmKwCc/mBM3OUJ1qrSiaRD1ZeRolps6Fl4LmRhbLW37tv3wXth/3W6DEOZpP+KRgsSAVzrMSLWWHUq5i7VrQMHNu0QU3gZ533PwSZeVGVgdsHy7TOuCQxefcv/lzS9aL9ya6xMoK"
Oct 27 14:07:05 volumio go-librespot[4263]: time="2025-10-27T14:07:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Oct 27 14:07:05 volumio go-librespot[4263]: time="2025-10-27T14:07:05Z" level=debug msg="completed keyexchange"
Oct 27 14:07:05 volumio go-librespot[4263]: time="2025-10-27T14:07:05Z" level=debug msg="completed challenge"
Oct 27 14:07:05 volumio volumio[3124]: SPOTIFY: SETTING SPOTIFY VOLUME 33
Oct 27 14:07:05 volumio volumio[3124]: info: Sending Spotify command with payload to local API: /player/volume
Oct 27 14:07:05 volumio go-librespot[4263]: time="2025-10-27T14:07:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Oct 27 14:07:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Oct 27 14:07:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Oct 27 14:07:05 volumio volumio[3124]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up
Oct 27 14:07:05 volumio volumio[3124]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 14:07:05 volumio volumio[3124]: Error: socket hang up
Oct 27 14:07:05 volumio volumio[3124]: at connResetException (node:internal/errors:720:14)
Oct 27 14:07:05 volumio volumio[3124]: at Socket.socketOnEnd (node:_http_client:519:23)
Oct 27 14:07:05 volumio volumio[3124]: at Socket.emit (node:events:526:35)
Oct 27 14:07:05 volumio volumio[3124]: at endReadableNT (node:internal/streams/readable:1376:12)
Oct 27 14:07:05 volumio volumio[3124]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
Oct 27 14:07:05 volumio volumio[3124]: code: 'ECONNRESET',
Oct 27 14:07:05 volumio volumio[3124]: response: undefined
Oct 27 14:07:05 volumio volumio[3124]: }
Oct 27 14:07:05 volumio volumio[3124]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 27 14:07:05 volumio sudo[4291]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-27 14:06'
Oct 27 14:07:05 volumio sudo[4291]: 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"