Oct 28 12:46:01 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:01 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 132. Oct 28 12:46:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:02 volumio go-librespot[24533]: go-librespot daemon starting... Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=debug msg="app state loaded" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" 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 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" 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 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" 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 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=info msg="zeroconf server listening on port 44345" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=debug msg="obtained new client token: AACXinrjSs8ObOaUdcgCLislaz6iaKK+0y+bQMW5/hZR/170KJYSQFDiiavjAOWZm7oci+l8ezwFWjZKn5zVWjrbN9ijeuhLp151cQTIGZJsfvKICiQ4mSlsmFj577hYW3QqMCxW/pUXOeU4IbKdnVYn6nuOw/Wklw/cwNxnytQO66OQ4Mrutwez3PMvsis5JR81zfIhKk/8svP9bgWUttBDZvwl0aWXwpJDh9LXLHE1hbrqtN5HDxw=" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=debug msg="completed keyexchange" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=debug msg="completed challenge" Oct 28 12:46:02 volumio go-librespot[24534]: time="2025-10-28T12:46:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:04 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:04 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 133. Oct 28 12:46:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:05 volumio go-librespot[24541]: go-librespot daemon starting... Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=debug msg="app state loaded" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" 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 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" 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 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" 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 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=info msg="zeroconf server listening on port 42807" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=debug msg="obtained new client token: AADEtxmUZzMaLElDbq5T7/N2VoIZn6J2wEYsv2GNI+OJYKhBHfLkvxZ2KIQRW2E50UMnUXYkI8g5jKKoYKpvLwOazKQhTIy+IRe3y1j69qflIvJyShMZIWlHnCAoVyND0Sz+2OZGKWMHzXSRdvgFByb0sEvqAUfSLLIqn17nu92exlIUuMzhTtMt35UZL0PjqXbaY1Ruelua9mGGuOzbEQ8drDY8pTk9qeUybVYpmoLWT6/lqTxetnc=" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=debug msg="completed keyexchange" Oct 28 12:46:05 volumio go-librespot[24542]: time="2025-10-28T12:46:05Z" level=debug msg="completed challenge" Oct 28 12:46:06 volumio go-librespot[24542]: time="2025-10-28T12:46:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:07 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:07 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 134. Oct 28 12:46:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:09 volumio go-librespot[24564]: go-librespot daemon starting... Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=debug msg="app state loaded" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" 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 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" 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 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" 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 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=info msg="zeroconf server listening on port 43291" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=debug msg="obtained new client token: AABYdJV81eCSCEImnF/mRL4oAKTkL2r/r+ADPgrWaHJffSii0Hovtx9eQFrGROIch/l5igIoK/UekI4pClWSl62Lb1625s4/TXzIVbnOdLy7RIPbi9gLfFzp4tlSRlC0Q9CLYNWxJxw3JCqBInE018s18EWJRwxXfKBBOc8bj8t0pkemKw/XJs9grMxw5PflK49n+mMnmCuACdHY7VmMno6qi8aJVXFm4ZD1mjSVPfg0P9i/kNRRRfU=" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=debug msg="completed keyexchange" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=debug msg="completed challenge" Oct 28 12:46:09 volumio go-librespot[24565]: time="2025-10-28T12:46:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:10 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:10 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 135. Oct 28 12:46:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:12 volumio go-librespot[24574]: go-librespot daemon starting... Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=debug msg="app state loaded" Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" 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 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" 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 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" 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 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=info msg="zeroconf server listening on port 43841" Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=debug msg="obtained new client token: AACJxvvGObjPaBewV5+5styZhzTCsc/CAatCBWah+EcIzzG8W2rYuJSPwCLjZi874gDWgsk5/Z3vAmpAu83OMXP0GEgSXM1NpvvSocwnuZKe5lEjR5T5UKwgMS6AS15fHfN0lJbqcEs/RMKa/PSWzOOpO1BereD2lfEFCHhgSMEf9Nc/lyMAVHV2CL1WJfi5GL09lqdfsd+AugYQ/oXbnqvspexztNwLYSkg5zzauRqT1EY9gaBJ+P4=" Oct 28 12:46:12 volumio go-librespot[24575]: time="2025-10-28T12:46:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:13 volumio go-librespot[24575]: time="2025-10-28T12:46:13Z" level=debug msg="completed keyexchange" Oct 28 12:46:13 volumio go-librespot[24575]: time="2025-10-28T12:46:13Z" level=debug msg="completed challenge" Oct 28 12:46:13 volumio go-librespot[24575]: time="2025-10-28T12:46:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:13 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:13 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:16 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:16 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 136. Oct 28 12:46:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:16 volumio go-librespot[24586]: go-librespot daemon starting... Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=debug msg="app state loaded" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" 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 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" 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 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" 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 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=info msg="zeroconf server listening on port 40557" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=debug msg="obtained new client token: AADFd/O9kcS6bUocd/Mxhtyr5jOz3togIfORgE/W6r+cw6b+huzgFv8xyYvqMDgt+hi0I6gjtfW+Zbi1p19R6VqARV+ryGmUszXIUTQj+au4U7fA0ulHfcsXz6a16H5C+GSCwEjeBhnIzJmEMSuABeD3l2PhTytIiXaq+DKg9/wmyUpV9bCD1DHqz4sDiTtgZ8F6ADL5Ny1fZFZHBby/l52sVVZAP4ZIQekC0XDrWqMi2ED/lr4B5ZE=" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=debug msg="completed keyexchange" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=debug msg="completed challenge" Oct 28 12:46:16 volumio go-librespot[24587]: time="2025-10-28T12:46:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:19 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:19 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 137. Oct 28 12:46:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:19 volumio go-librespot[24609]: go-librespot daemon starting... Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=debug msg="app state loaded" Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" 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 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" 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 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" 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 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=info msg="zeroconf server listening on port 42315" Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=debug msg="obtained new client token: AABcFXecAclV5/WXc3BHc6Bfg2P8meK04GxYRB8nhc58QVpft638rE0X6uRrdwj48b6bjXpVbHV8rcZY94b/2ChNqetTYILUFAiZPGJISnfNoTqTq2qX4NuqO+Rfet0v1eO55XdVTVvIDX1OTjLXURgPQyLJebKdwLy44hL7EZ8h+I/UD6Cllvw8Y86eMuB4GADkeN6PGZ6rGfyaKGOACjXSYV+SVKD2T+cuY/joKYDDL4IJq6dOCDE=" Oct 28 12:46:19 volumio go-librespot[24610]: time="2025-10-28T12:46:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:20 volumio go-librespot[24610]: time="2025-10-28T12:46:20Z" level=debug msg="completed keyexchange" Oct 28 12:46:20 volumio go-librespot[24610]: time="2025-10-28T12:46:20Z" level=debug msg="completed challenge" Oct 28 12:46:20 volumio go-librespot[24610]: time="2025-10-28T12:46:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:22 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:22 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 138. Oct 28 12:46:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:23 volumio go-librespot[24617]: go-librespot daemon starting... Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=debug msg="app state loaded" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" 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 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" 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 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" 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 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=info msg="zeroconf server listening on port 39767" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=debug msg="obtained new client token: AACLPyhxNimzQq/YI8+vqrEu6hFBnAfimE6FpHzQv6+Ec5xMh5NmCE8wygl54bdC4MCfSVoDIdmW+lZJrrFlSatxKmugkgpFLyuVOei+4uCXCmY4bIx6Y+g7+oGp5R+kN3etSIJkW8oqP/bo000jVdUH5G9/zzsaXskzJeCv+i59PX/Sk1qOAu/a6BCqqVDFzpbAM3JzEt0edbREB6lM07dqBn0y1u6irktGHyDw/+G7Ay7fu2Rrnio=" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=debug msg="completed keyexchange" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=debug msg="completed challenge" Oct 28 12:46:23 volumio go-librespot[24618]: time="2025-10-28T12:46:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:25 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:25 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 139. Oct 28 12:46:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:26 volumio go-librespot[24625]: go-librespot daemon starting... Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=debug msg="app state loaded" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" 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 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" 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 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" 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 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=info msg="zeroconf server listening on port 44141" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=debug msg="obtained new client token: AAA4bWU79FEXgOgHBK9Hk0ILKnBi+7RBheZfjDnyj0tTggLCTQEH65fd/aCT4Z/htK1jhObLgRJuLEOQivJ4TZNP1zfvS5J8xb0Xs+Lqr1YE2FP+Dm/cnAM7+OIsdYdaL1uE6sXhHAVAdcttBf6P3jPhNBX2JhVHzVdAIU+h3c67HLjja3XfvFndVVWF/7CT38FGyO+mqw5WRAXkj9lxwODTRR5zLRukA0PFQSTI1ztMBR6SZ8qujKM=" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=debug msg="completed keyexchange" Oct 28 12:46:26 volumio go-librespot[24626]: time="2025-10-28T12:46:26Z" level=debug msg="completed challenge" Oct 28 12:46:27 volumio go-librespot[24626]: time="2025-10-28T12:46:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:28 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:28 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 140. Oct 28 12:46:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:30 volumio go-librespot[24648]: go-librespot daemon starting... Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=debug msg="app state loaded" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" 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 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" 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 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" 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 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=info msg="zeroconf server listening on port 32919" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=debug msg="obtained new client token: AAAvN5A8mC5R1BRgYqRRy4yw/f7soH4Kq4HD5iQ7ri2c78d123s7n4ootpCnJmUACdNHNnnsgFQQKlRlTf4OeFWFS8H6GoEPQ+/xwW/5XTDEldKgaQdhr1A2S9ShBxMgXdHQpLcT7ObF2YZiDSyMsuo6wDSi54vtsFx8ZI2/7/5kEwYhA11bpxzBZDz7A8hP+N4ZIrTw3+hTrCgnyrqPT12VUag1Ehl8eoxbnPGAeWvzs1zm0x/30Gc=" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=debug msg="completed keyexchange" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=debug msg="completed challenge" Oct 28 12:46:30 volumio go-librespot[24649]: time="2025-10-28T12:46:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:31 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:31 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 141. Oct 28 12:46:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:33 volumio go-librespot[24660]: go-librespot daemon starting... Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=debug msg="app state loaded" Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" 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 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" 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 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" 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 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=info msg="zeroconf server listening on port 43037" Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=debug msg="obtained new client token: AADN6pxIIuBbafOkxUmS7zpbkNemKl5mDfQnblNVI9aaX0JwjsjwrGr3cKZwFTTRoHvbz5OPwUqODo2ZdFs9v0uEdWZiYSUl2zSpxINC4YhYwrPr0jo1syTsPYocUrRbirh4atbopqQOK+1dCWx0Hdd2+MprRT5Uk8SAZtJ+dm7A7DoLwNbl2tea5DcXlkKEAfyVS0daIDph5xb4SKzamixvhoUODYd7hh08nlWm0JAafChe8aHiA2E=" Oct 28 12:46:33 volumio go-librespot[24661]: time="2025-10-28T12:46:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:34 volumio go-librespot[24661]: time="2025-10-28T12:46:34Z" level=debug msg="completed keyexchange" Oct 28 12:46:34 volumio go-librespot[24661]: time="2025-10-28T12:46:34Z" level=debug msg="completed challenge" Oct 28 12:46:34 volumio go-librespot[24661]: time="2025-10-28T12:46:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:34 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:34 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:37 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:37 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 142. Oct 28 12:46:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:37 volumio go-librespot[24668]: go-librespot daemon starting... Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=debug msg="app state loaded" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" 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 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" 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 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" 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 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=info msg="zeroconf server listening on port 40417" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=debug msg="obtained new client token: AADoksZoQO+Kxexzn+WF19C03K8s7/4+ge5MPneg6G07Gh7qTZvaLSSCgDMJoChcE3IRDYXyS/tUxXXYctLUBW/0X5zFeat4QC2+iuZ4ObJFQ879S42rD58G6R8OGREUJvp/uAd831flBuQ7KChfmTfrZhOoY0I3UOgKweDOLGCF4XgHRyMdiSl/HqEaQDS38cR/yomkhcGIg/FfEy9jxD5Dn1Auj4bwfAqgySxtsY1kvoRgLp4CUMw=" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=debug msg="completed keyexchange" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=debug msg="completed challenge" Oct 28 12:46:37 volumio go-librespot[24669]: time="2025-10-28T12:46:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:40 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:40 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 143. Oct 28 12:46:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:40 volumio go-librespot[24690]: go-librespot daemon starting... Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=debug msg="app state loaded" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" 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 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" 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 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" 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 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=info msg="zeroconf server listening on port 46341" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=debug msg="obtained new client token: AACknuizoN7PVeJ1w9koxgp9BqGWGzeLfSapOacbVcc2y3TU3t9U7IrB2tK/+7i+vaXcbEqzZWUNrTB+8v7C7a8PrVmKgu++z62wFkw2ojIPd4WE8Ub5snmlQ0UHMDIuAVpDtR8SK2+4Ri9SrubB613jusjG0C9B3Uf9/878vdt6voQfAfeFATSspQ+52XX6rrEhI/sR6g3LGcHJzOt9fAkhmSmC6VS9BW6vzrfFTQ52hoi0UPkarv4=" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=debug msg="completed keyexchange" Oct 28 12:46:40 volumio go-librespot[24691]: time="2025-10-28T12:46:40Z" level=debug msg="completed challenge" Oct 28 12:46:41 volumio go-librespot[24691]: time="2025-10-28T12:46:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:43 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:43 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 144. Oct 28 12:46:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:44 volumio go-librespot[24698]: go-librespot daemon starting... Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=debug msg="app state loaded" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" 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 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" 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 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" 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 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=info msg="zeroconf server listening on port 38823" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=debug msg="obtained new client token: AAB4xT/6NLZcXYaDKk9qM+0ycmGTjU5YGB7mi0I0CYfXdtqvLv0lOgAevKpBkumSznMQzx82bNGD24301XwA3oYa8D1CesXAEUWwzVsaBtDeSYhEHFoRP7sOvqKJVw2ISGx0Va8/125jzn+MH/Ie7QmGpUzKFZNaEz/f23jviW++TJAUWgllTBuQY7qFqQRuA3mp5E4hAjlzh+z9V1IJvPo0BEA3ibpkwmB6JBqGobOzOaHYQxXAnPk=" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=debug msg="completed keyexchange" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=debug msg="completed challenge" Oct 28 12:46:44 volumio go-librespot[24699]: time="2025-10-28T12:46:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:46 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:46 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 145. Oct 28 12:46:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:47 volumio go-librespot[24707]: go-librespot daemon starting... Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=debug msg="app state loaded" Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" 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 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" 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 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" 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 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=info msg="zeroconf server listening on port 45999" Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=debug msg="obtained new client token: AABbN0ZevrmAzSL9lmrjfyqpGHqWBztk0SBy7Grlw56ptpBj/d9+29r5VlfhYz4GnaSFw5K17qQFmHUm8IYF+zjT3iZGfnrcDFitxFKXqX+w5TSXwhzZqJYNYqFjp7SufzR6CTWGldVPFinJYptDC1eroPv5CaWLz5p3z0tsO9AXunVgLqH2/diUM/T77oqghwrMxa778DIUFd9OfpC9d++VJkzIwic+GLejl2MQyS7uqbDM/hisaPo=" Oct 28 12:46:47 volumio go-librespot[24708]: time="2025-10-28T12:46:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:48 volumio go-librespot[24708]: time="2025-10-28T12:46:48Z" level=debug msg="completed keyexchange" Oct 28 12:46:48 volumio go-librespot[24708]: time="2025-10-28T12:46:48Z" level=debug msg="completed challenge" Oct 28 12:46:48 volumio go-librespot[24708]: time="2025-10-28T12:46:48Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:49 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:49 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 146. Oct 28 12:46:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:51 volumio go-librespot[24730]: go-librespot daemon starting... Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=debug msg="app state loaded" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" 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 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" 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 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" 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 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=info msg="zeroconf server listening on port 45653" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=debug msg="obtained new client token: AAAJexQQSSk3mXBNCNtvazBaoLWpnSq7dfCQRAnwT1tfgIEXH2uCR9gOxahlvbnZv0okVY31xXYWvIO4zlXlDui0I494zBijP1hlxYFX2PppFj/Z0xlIKySbb8g9nLcS9YwjasUhZN84uNULwXBw/3j3KTlElIZNT+8LwrgLlfTDvMLBdQXjTHCD97CssPm8s2RYW3tDOGx3vMbEPu0FHvAKn1YM4c1+0MW5pDwYjISlcLsbChtOMaE=" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=debug msg="completed keyexchange" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=debug msg="completed challenge" Oct 28 12:46:51 volumio go-librespot[24731]: time="2025-10-28T12:46:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:52 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:52 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 147. Oct 28 12:46:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:54 volumio go-librespot[24741]: go-librespot daemon starting... Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=debug msg="app state loaded" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" 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 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" 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 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" 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 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=info msg="zeroconf server listening on port 46165" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=debug msg="obtained new client token: AABt/FqZmOtr2p9eLbpbyvX7NoPMWYOjLIu1/0xdAzJ6S8BX+yTrzAALjjT0EZ7Ds/6WiiEhystNHpyZ6FWE2yGaksF1Xn/5lCPctJ4fJ4vQirSuVaCC94uelWv35qzq6+8oM1r49cuOt/xeoawZ4X398CkoQvtlbZBlrHIJLOfLqKSJnawrH58agbDi3EptmHekwZ36wTUiBOB3zdQgnaiOJpCt+nXVOUWqQkCjuYwoKCPayDQwU+M=" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=debug msg="completed keyexchange" Oct 28 12:46:54 volumio go-librespot[24742]: time="2025-10-28T12:46:54Z" level=debug msg="completed challenge" Oct 28 12:46:55 volumio go-librespot[24742]: time="2025-10-28T12:46:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:46:55 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:55 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:58 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:46:58 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:46:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 148. Oct 28 12:46:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:46:58 volumio go-librespot[24763]: go-librespot daemon starting... Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=debug msg="app state loaded" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" 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 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" 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 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" 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 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=info msg="zeroconf server listening on port 39557" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=debug msg="obtained new client token: AAAarpty/WJ7ic9NBLFoX1yBAFLrl6W5Uu//K+en3JVb/LSjjKnSqMuJXlkrBaJdFAYbjBxCqbZA8Dk/nnoNkKDE37RjO9B/a48p25vcxGmsjQl/3IbM+rkX1Hbkn9eJ1ZNSGSdjyHDpV7dfOXQXW0q60SasSIdODhxvadEUGTzz+xWFHSoLvX0v+J2j/Y2FUZ5dU8YsoH3vxTKhkDDVNk3fHGviSZpMI08Hb8UeTR74tF+OMCtP3lQ=" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=debug msg="completed keyexchange" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=debug msg="completed challenge" Oct 28 12:46:58 volumio go-librespot[24764]: time="2025-10-28T12:46:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:46:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:46:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:01 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:01 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 149. Oct 28 12:47:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:01 volumio go-librespot[24772]: go-librespot daemon starting... Oct 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" level=debug msg="app state loaded" Oct 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" 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 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" 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 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" 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 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" level=info msg="zeroconf server listening on port 39233" Oct 28 12:47:01 volumio go-librespot[24773]: time="2025-10-28T12:47:01Z" level=debug msg="obtained new client token: AADdSF2MAKw/UV7mKCcAfkX6v4lV9Fk8ETuEmtbLAmK0Qc/3ZE03+3xTkixZto60GjHniknpYwerR8a+JpdObnw3/zVc2jZjaEJNu1EUlKLxMeM1bI8qLdFgjWI1wBcfWXeFcSzE4TK2AsNSiwOU/Lnz4sHMH4uo+U0jOvkUlnPnL5ge3nOcLluJCP8xOVuhBp6coslISK0FQM1It3XgQkWgCEA6uJ6jGUm4kW4TzH9Pf7VwIhb9eY8=" Oct 28 12:47:02 volumio go-librespot[24773]: time="2025-10-28T12:47:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:47:02 volumio go-librespot[24773]: time="2025-10-28T12:47:02Z" level=debug msg="completed keyexchange" Oct 28 12:47:02 volumio go-librespot[24773]: time="2025-10-28T12:47:02Z" level=debug msg="completed challenge" Oct 28 12:47:02 volumio go-librespot[24773]: time="2025-10-28T12:47:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:47:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:47:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:04 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:04 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 150. Oct 28 12:47:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:05 volumio go-librespot[24780]: go-librespot daemon starting... Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=debug msg="app state loaded" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" 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 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" 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 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" 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 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=info msg="zeroconf server listening on port 45749" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=debug msg="obtained new client token: AABwZDmm41ASA5kSAV7iUGmhBctyL3hOEMBo3bpjbwGL5gvnNKlFNcyBoeFnC7uOjeOjvPNOzOWlnYNUjj7VU+sf9fs3i2ABTH5+Ud18bwt6knMHSLzjHZZNCKK8iFnFuSN5IqAucg6UPSPrV6XMlpRrtO/OuONC+OjueNo61sAfeiNBovwQjFfDwoxxdvEPHRnMC/+7uNaFnJy+eC1JLmYxiBH1jUu303fzaSmPEyvbU9+Vijq1LPM=" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=debug msg="completed keyexchange" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47:05Z" level=debug msg="completed challenge" Oct 28 12:47:05 volumio go-librespot[24781]: time="2025-10-28T12:47: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 28 12:47:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:47:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:07 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:07 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 151. Oct 28 12:47:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:08 volumio go-librespot[24803]: go-librespot daemon starting... Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=debug msg="app state loaded" Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" 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 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" 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 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" 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 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=info msg="zeroconf server listening on port 40821" Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=debug msg="obtained new client token: AAAv3Wd3QJM5n2PcVyqoVo/4P0qp3GXG6HuFAHjhERfEm1u0vchoXjD/xsKWuuGb4wYM1jC2cXCyENPldRge12b2kbLfECDqdHYYDqKJd8u21OzyNuF7EWG6jPlkHzdkBfhnrqkuP2RPDEo4oKEfvz9lLEDht+S0gKKJQdXiXBNm+FCeDGWQOuGDq6YcIzPOK82Rck7OUdv6Uv2xjlcnTpkbXwyUOhMKoLCY8w2XMcE8cIM9Fd1sPAM=" Oct 28 12:47:08 volumio go-librespot[24804]: time="2025-10-28T12:47:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:47:09 volumio go-librespot[24804]: time="2025-10-28T12:47:09Z" level=debug msg="completed keyexchange" Oct 28 12:47:09 volumio go-librespot[24804]: time="2025-10-28T12:47:09Z" level=debug msg="completed challenge" Oct 28 12:47:09 volumio go-librespot[24804]: time="2025-10-28T12:47:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:47:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:47:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:10 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:10 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 152. Oct 28 12:47:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:12 volumio go-librespot[24812]: go-librespot daemon starting... Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=debug msg="app state loaded" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" 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 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" 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 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" 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 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=info msg="zeroconf server listening on port 40321" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=debug msg="obtained new client token: AAA7lhRAiIi0CBZNDwGo/jzoado1yl9xeJD0nV/Khu3EN39cCjsWgufjTwcBbB4Y1+3r1KynwJobY3PcnkgX0uM+EY+T8Uc2HwFQaLV7NHKLfzHdECCnwhir4ICd/x4blQUz/oTQ4F76OGm2QF6YY1BcAWyWdaU61npayOVLMvCGuG8dgYyPcR0oI4v9RPorbR5Ihgy/O3F7Hcepth5EbYt/oNaDWy1B1AgsOU0hm/zH443p/+V5ES8=" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=debug msg="completed keyexchange" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=debug msg="completed challenge" Oct 28 12:47:12 volumio go-librespot[24813]: time="2025-10-28T12:47:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:47:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:47:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:13 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:13 volumio volumio[24021]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 153. Oct 28 12:47:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 28 12:47:15 volumio go-librespot[24823]: go-librespot daemon starting... Oct 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" level=info msg="running go-librespot 0.4.0" Oct 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" level=debug msg="app state loaded" Oct 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" 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 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" 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 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" 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 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" level=info msg="zeroconf server listening on port 45759" Oct 28 12:47:15 volumio go-librespot[24824]: time="2025-10-28T12:47:15Z" level=debug msg="obtained new client token: AAAkn8jgCR3KyvH9FUvo8wtZG4KudywEXhjB1waW746KzjQkb/cqBMxnBuJu7RO5MeprVCAxh6oLsD13NcGI8OFjyMd4QvnHQK7c29loF9/RLh/M/SqfBaPWZCMapIth5St8+/mDlj52jO3hmoAYZXf0bntIWm4/wdP78Ctc7rviAFjYVHAxctjxLY+xkUcC53YoTcdX8u+1S57muE3bZ6XhNirx7Cjw7+fZDPWLtGzEgLecDMXZTEA=" Oct 28 12:47:16 volumio go-librespot[24824]: time="2025-10-28T12:47:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 28 12:47:16 volumio volumio[24021]: info: Initializing connection to go-librespot Websocket Oct 28 12:47:16 volumio volumio[24021]: info: Connection to go-librespot Websocket established Oct 28 12:47:16 volumio go-librespot[24824]: time="2025-10-28T12:47:16Z" level=debug msg="new websocket client" Oct 28 12:47:16 volumio go-librespot[24824]: time="2025-10-28T12:47:16Z" level=debug msg="completed keyexchange" Oct 28 12:47:16 volumio go-librespot[24824]: time="2025-10-28T12:47:16Z" level=debug msg="completed challenge" Oct 28 12:47:16 volumio go-librespot[24824]: time="2025-10-28T12:47:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Oct 28 12:47:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 28 12:47:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 28 12:47:16 volumio volumio[24021]: info: Connection to go-librespot Websocket closed Oct 28 12:47:19 volumio volumio[24021]: info: Getting Spotify volume Oct 28 12:47:19 volumio volumio[24021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 12:47:19 volumio volumio[24021]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 28 12:47:19 volumio volumio[24021]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 28 12:47:19 volumio volumio[24021]: errno: -111, Oct 28 12:47:19 volumio volumio[24021]: code: 'ECONNREFUSED', Oct 28 12:47:19 volumio volumio[24021]: syscall: 'connect', Oct 28 12:47:19 volumio volumio[24021]: address: '127.0.0.1', Oct 28 12:47:19 volumio volumio[24021]: port: 9879, Oct 28 12:47:19 volumio volumio[24021]: response: undefined Oct 28 12:47:19 volumio volumio[24021]: } Oct 28 12:47:19 volumio volumio[24021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 12:47:19 volumio sudo[24859]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-28 12:46' Oct 28 12:47:19 volumio sudo[24859]: 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"