Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 23:57:00 volumio volumio-remote-updater[874]: Test mode disabled Nov 03 23:57:00 volumio volumio-remote-updater[874]: Alpha mode disabled Nov 03 23:57:00 volumio volumio-remote-updater[874]: Alpha legacy test mode disabled Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 03 23:57:00 volumio volumio[13130]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 23:57:00 volumio volumio[13130]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 23:57:00 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:00 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Nov 03 23:57:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:02 volumio go-librespot[13556]: go-librespot daemon starting... Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="app state loaded" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=info msg="zeroconf server listening on port 34337" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="obtained new client token: AACfRXQIicvCfm/R5UaxaRNYUki7a3EsR1v70zdKE/22lrtSYoNqAki7cdsawWnHMnFCieXLZULtfkBTiC8yK2C4zGV7XtflxxumWjrlVX2yx8V4QN9N1mk9S6q9akfTGuDm4DPpkqe8qQxNCwSMZFIf93/i+GnVnbkDmILDR4ANC54hNlTcyWa3nLDuPdLzVT7C/nwWmSmVATEr+poRlZPSPKK044gQjXKdWzbbkMlyG5/ptX4R" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="completed keyexchange" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=debug msg="completed challenge" Nov 03 23:57:02 volumio go-librespot[13557]: time="2025-11-03T23:57:02Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:03 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:03 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Nov 03 23:57:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:05 volumio go-librespot[13564]: go-librespot daemon starting... Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="app state loaded" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=info msg="zeroconf server listening on port 39259" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="obtained new client token: AACEaM+YsQt01k/TOL48p1eqNtWdpf+ObL7Gl90LreQGXyC0N0SVDbYNSyh5Afd+xuCDHAcSnZ92QST420xSvKZbJ1jsLTwVtYUOXr7meQXz+2N8nNX8MInONEJ9NFMNScfcJfQv9/q990AslR1funqK0/zVsOFT0P2zVyAg3WdfXh3xokQ/ZPQemR5++9QlRpyYOKY+/MdWOWiAkJ7TViCqp11YuwWr4HKZLVBs3/yhjG0/iDJnAGc=" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="completed keyexchange" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=debug msg="completed challenge" Nov 03 23:57:05 volumio go-librespot[13565]: time="2025-11-03T23:57:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:06 volumio volumio[13130]: info: BOOT COMPLETED Nov 03 23:57:06 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:06 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Nov 03 23:57:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:09 volumio go-librespot[13587]: go-librespot daemon starting... Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="app state loaded" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=info msg="zeroconf server listening on port 33451" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="obtained new client token: AAA+Mn0Twf5zVIxM/IcXUdsHyOf28Q3nfxmpuq0J+D/vMbej4yrV2Tql71b7VF/MIVBSdpsjj5SJV1b/7DMY7yp34kaaN1FJsUZUlV2GoKWQktsmB5xsjCZkeYm6vcaEGLpCYkVz3LOiws/aOqUoy5PhAbs5VY9WMnDWA+lHfnLLDdkCqkcDU5IVDic+48VI9niI/1xLNW4BQM3XU9ihKAvUWt0o31qzVRaHXcgF+pdGTUeQ1gS2" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="completed keyexchange" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=debug msg="completed challenge" Nov 03 23:57:09 volumio go-librespot[13588]: time="2025-11-03T23:57:09Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:09 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:09 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Nov 03 23:57:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:12 volumio go-librespot[13595]: go-librespot daemon starting... Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="app state loaded" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=info msg="zeroconf server listening on port 35549" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="obtained new client token: AAB/j3Zjob9f0y1hKxBl/eWDKT0J2U6f2fqwgbVosYkRr2ThFAtuRh9MFcsaQARwhP1cinQ232XQxCb+F3PAD2rqe5eE0bR9C6J/VBLsu4FUzeGstqLdNHNFJodYKwzPQ3DCMfw8WTnUV8OCNw85YINO9U5khRFcpg0kGq0r28Jjl0zFGjXWXEQNj59+v0tgzh++sxDRuZ/jdinsedArsf6CpzC893mh8p7T4RpaGvaYwsp7hUSKd+g=" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="completed keyexchange" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=debug msg="completed challenge" Nov 03 23:57:12 volumio go-librespot[13596]: time="2025-11-03T23:57:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:12 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:12 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:15 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:15 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Nov 03 23:57:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:16 volumio go-librespot[13606]: go-librespot daemon starting... Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="app state loaded" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=info msg="zeroconf server listening on port 42005" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="obtained new client token: AAD4fad6YzLirervb6vx7g7imPfWCL8ekirav9QLv17GLa6GQi/VKFH1sYP86iEiCBfNw5bIEZz41eDUL6D+HMf65Epw2HD8o/jHSDscThBuNjYF26aOn12dP1RNOYIJidhaRS/qW/cfockOxsI3muwqGuGL5Oz7HLdw5eCP04PyjcqK6xt1BquI/ClYLUitsNZAZiUUx4yqNypmW3wug6HsI3YvBG9GYWlzc0s/ccX//l2vKOGF" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="completed keyexchange" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=debug msg="completed challenge" Nov 03 23:57:16 volumio go-librespot[13607]: time="2025-11-03T23:57:16Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:18 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:18 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90. Nov 03 23:57:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:19 volumio go-librespot[13628]: go-librespot daemon starting... Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="app state loaded" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=info msg="zeroconf server listening on port 36067" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="obtained new client token: AACHuJTw0zvZzIXPODQ6JPwGqmHczmr/xAjEeZ7w0AccuX5siZ4kp64E3z1Z32AZxhXzoXWAxbkteECC5LHkuho/sXLj1mu1wsvbyMUL+QlL783okiFn9kdqHNUJR+BJp2wtejctyqzkC8GDLYQBPsG3sMJiW93PYqB9qJbsezMdWscR7mK0WvEGVzc92zQ6wU7VDjC6vmXivGMtPtDXAnf8YOP/sKTwpWG3YX0ShL43lsuUSDnzFtY=" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="completed keyexchange" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=debug msg="completed challenge" Nov 03 23:57:19 volumio go-librespot[13629]: time="2025-11-03T23:57:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:21 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:21 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91. Nov 03 23:57:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:23 volumio go-librespot[13637]: go-librespot daemon starting... Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="app state loaded" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=info msg="zeroconf server listening on port 39835" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="obtained new client token: AADRp8hb7LVPGwCltHAtql4sB1hdURwv3zMGegCKC4tCuJVwi4ZwXW89lfv7Coy3Xa7S6Der+j9BOVyUVqGc1HykGQWU/P3wXLjLroFVCuCp2ddcI3pKNzSWrowzQ4xA+PIU4gW+5NvVeYZeF2YyCDgUECTKa2XrgBQjkxKhLEU7hpGxYP7jED4+18/IHuJsw3BTPYYXS5d5RBhm97OJ0Xdc9hkG/gVClybBJn/ukzKExdDwVEaK" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="completed keyexchange" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=debug msg="completed challenge" Nov 03 23:57:23 volumio go-librespot[13638]: time="2025-11-03T23:57:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:24 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:24 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92. Nov 03 23:57:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:26 volumio go-librespot[13646]: go-librespot daemon starting... Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="app state loaded" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=info msg="zeroconf server listening on port 37731" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="obtained new client token: AAAri6M5WtxVjGKWk8LYLmp1Ta6KYBj2FH4DZ869GWMXJsFgzJvxff0AVXhLBpdjzWgMMn1WUNyohJvxpOucnToQdqISFU3AxtsP6qMzvBWtIh0NOtNDfu6z1pTjWGVy2M5YlKHXo65EFZj9XfOYFn3Kudrj/w1ZonoYQaW+QgmDjotXvGN7L3Cd1FP020DZ0nzM2hXWAOm4eHZiNFB8AEvhD+XInJlU0ll1gNXrRQumaFy5yKUUuIA=" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="completed keyexchange" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=debug msg="completed challenge" Nov 03 23:57:26 volumio go-librespot[13647]: time="2025-11-03T23:57:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:27 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:27 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Nov 03 23:57:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:30 volumio go-librespot[13668]: go-librespot daemon starting... Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="app state loaded" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=info msg="zeroconf server listening on port 43663" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="obtained new client token: AACY8EGOaHjMyiNMBKy9Hzf/frpmRRywOlP8W5WDNcAWVZR0Mat/AS09uYbDEtmEo9fRetzqcoQQXlZ63Gniu+j55quE2SVXLMd2op/SMQlSAuDUNytIoxY/ESRjvyTbRF6HcVJif2b7dugdcmAowcZMB4l+nwP2LiQ9fE3gGBSLbSLA5oXU4OXQAgtFw8MSzylaCRTuznBhxC45eVpPi3eolAPARbLgki4jj3YWLRxonq+2KnkD" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="completed keyexchange" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=debug msg="completed challenge" Nov 03 23:57:30 volumio go-librespot[13669]: time="2025-11-03T23:57:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:30 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:30 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 94. Nov 03 23:57:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:33 volumio go-librespot[13677]: go-librespot daemon starting... Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="app state loaded" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57: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-gae2.spotify.com:80]" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=info msg="zeroconf server listening on port 44659" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="obtained new client token: AABRC87CEv3d9xTaKag2Kycjq9FUcWTZWpj6g4PvX4/y42mksgPHGuo5jCLNBHPRNLjdBP+b9ezq6GGkHGginjMnewFolUfsybyz7vfhgAm1FfShJ7f1TDjXt3V5J7yihARwa102rIhlSxPegyGVzL2d6aOI5tEs2R3FBWdiU99FWYDZAx8kJveJXBBK0hi7XOSgR4FDsWRrroM9ZCBdYJTLqE1ggoIdkcw01nIBxOHytN37GSiau7o=" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="completed keyexchange" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=debug msg="completed challenge" Nov 03 23:57:33 volumio go-librespot[13678]: time="2025-11-03T23:57:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:34 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:34 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:37 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:37 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Nov 03 23:57:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:37 volumio go-librespot[13688]: go-librespot daemon starting... Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=debug msg="app state loaded" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57: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]" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57: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]" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57: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]" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=info msg="zeroconf server listening on port 34063" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=debug msg="obtained new client token: AAA/DWssPSDArq0nGmSRD5E2KVC2D4ndOOcomo4VEGd6Qi3Fhbxbg6CvvJV2N5voO6ebgBE/CVxVvf3Xkcra/IE0ByAHBsNC2LCZoJMxSeyaLYEO1mt+EKy4Lc5T6ScaXnrB4AOAfTEdmJ1spVesUjF2qoL22q8VUAhjbufZrVN8glra9ex/7cEQn88o/7mxJ1sH4WEEvFzBdw6CSScHDA0RT2C8GJNBY7TTmcC39qnDA5fHsVYO" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=debug msg="completed keyexchange" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=debug msg="completed challenge" Nov 03 23:57:37 volumio go-librespot[13689]: time="2025-11-03T23:57:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:40 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:40 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Nov 03 23:57:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:40 volumio go-librespot[13710]: go-librespot daemon starting... Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=debug msg="app state loaded" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57: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]" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57: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]" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57: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]" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=info msg="zeroconf server listening on port 42753" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=debug msg="obtained new client token: AAAhkyI111Rt8pJOmJ99KH1kEiu0a3RHHFFGUVBAV79TkkBkhS+we4yhYJXs1rbVQz1jaAP2u1EVw6Mps0klV+fHQJ9LdBoDeocyvZYU2v9HLforUd16XBJdRvGi2q5BJ4kLKF0TgzOpm1HUaCNXNIKnal4HufAg619YSKmJivygigl4j5CETOQ9ObW+ndMSE/A350QaVC9gBTYuYkJlYuJntlTfsQhz8F5LDM0TuqXzIsKOO6NJKlA=" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=debug msg="completed keyexchange" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=debug msg="completed challenge" Nov 03 23:57:40 volumio go-librespot[13711]: time="2025-11-03T23:57:40Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:43 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:43 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Nov 03 23:57:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:44 volumio go-librespot[13719]: go-librespot daemon starting... Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="app state loaded" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=info msg="zeroconf server listening on port 41463" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="obtained new client token: AABW+yUJT9Oi4Quq1orXLP8Cyn/448GyKA/VYZNZP+XwsEtxzM20cakjm9SYg+J4BY7Rrhzz+644WMbqeRAdxV4wVWN60cEumxeXyY2LoH8cx5M/09rIwLCEirNcMwQsib2TNhjVV+CT6gnDEH/TUZYpM76KMjqgepz+UV47eAl1bIyKb/t6aStR3c+tePiNYxDBWr4yquuCdiitVZNes+7Qfhy5970jRFcirGpv0GO5CVfUsqWo" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="completed keyexchange" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=debug msg="completed challenge" Nov 03 23:57:44 volumio go-librespot[13720]: time="2025-11-03T23:57:44Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:46 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:46 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Nov 03 23:57:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:47 volumio go-librespot[13728]: go-librespot daemon starting... Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="app state loaded" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=info msg="zeroconf server listening on port 39791" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="obtained new client token: AAA09HyJUR8uNQnzFQ1m8USdaX5tZOgmCpJZIElBZgxo3T5fAdAgrv78LHOZn8YRU40VmkgzYkUmbbz8oY0Q6/FWwEGdPiLELWdRWVJU8RsiOYYBbY8WjhBxPGf1wfqWcGU0zEswV5wFDrxOvXJO1x+cO6Ho1nY0hPQ76UlWCNTx7cf+vSU9SuJ2WxE6uAqlx0VY8VE43wE7jt/ctNBo94l18OS6kEvltBemB6PKqnMxDBwdujhCOZw=" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="completed keyexchange" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=debug msg="completed challenge" Nov 03 23:57:47 volumio go-librespot[13729]: time="2025-11-03T23:57:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:49 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:49 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Nov 03 23:57:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:51 volumio go-librespot[13750]: go-librespot daemon starting... Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="app state loaded" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57: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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=info msg="zeroconf server listening on port 45717" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="obtained new client token: AAB3nUisRRLd/Qv7391I84LkaFLQXuzBA+Hz00iWKwyNzcZLk5zZDx3l3NTHvP+asLunLPKoBBUu3Ls1wwm0arDt1dtQoQ2XtccoR3x9He+mRneX2NUztmTQF8wMfOpNEoBOcQvbD/RZlVbK7/6Q1IT7AfulDLEr/1QPis/Sjj+BApaeY7Hdp++lAEIqYVZcAyzwMJDe19FCff48lNp7gSz4V4A1Rb7Eh4YyB0vqlRB+HmOxnvv0" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="completed keyexchange" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=debug msg="completed challenge" Nov 03 23:57:51 volumio go-librespot[13751]: time="2025-11-03T23:57:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:52 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:52 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Nov 03 23:57:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:54 volumio go-librespot[13761]: go-librespot daemon starting... Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="app state loaded" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=info msg="zeroconf server listening on port 35939" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="obtained new client token: AAASKfULdec6TsTZszu+RtuvdcarHaarPv4ArL1uHvfk5lPidz3O5e7uaszo1nTio0V1XxxkSpkxEir+D6fvJnxacppjvYHH1mKIY8qkNQ6mnGIcAHjXN4HIT1/eRr7eZIinIkjaltDYG0cV/uBObOuGXVb5fU7ETav9tgvf2eQtQMou/C69bqk3X/zHxC9AsCGEwUWEiMZJSS7ZCnkBaW5eA7nYQhe+Spy8JTdxUbOaPdtM9QapXAc=" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="completed keyexchange" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=debug msg="completed challenge" Nov 03 23:57:54 volumio go-librespot[13762]: time="2025-11-03T23:57:54Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:57:55 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:55 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:58 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:57:58 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:57:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Nov 03 23:57:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:57:58 volumio go-librespot[13769]: go-librespot daemon starting... Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="app state loaded" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=info msg="zeroconf server listening on port 33283" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="obtained new client token: AADl97F+Jj8mR3rVp8XstE2bio1M9SsPHnVnMwZ0y9BTYl3Gl6+D4q4deYjXEvQPn0o5ISbBAECt4MoYgJowVDoKiCQ6rL8MqxwOuGNz85LW6qbCO/P0WnUESFGVtZ1bhoUrAJ8pK85p6TplcAWFoqJDb8xHAmNYjxQzfpuk1kssY4nDCHbtc4mMnatvwwFUNZ3nkcT9BZp7abInhVCONRcWw0LqLv5nwTh87EaEPQ/8Fp9XSJDR" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="completed keyexchange" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=debug msg="completed challenge" Nov 03 23:57:58 volumio go-librespot[13770]: time="2025-11-03T23:57:58Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:57:58 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:57:58 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:01 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:01 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Nov 03 23:58:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:01 volumio go-librespot[13791]: go-librespot daemon starting... Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="app state loaded" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=info msg="zeroconf server listening on port 40153" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="obtained new client token: AADCVE9bfQN1o/uPsSJACdSBSQRXRnCzpDNTjHwqKoK+/UEMGXk9ivmbfBakXksufAupv1FwzJo3it5KhcZNneak71tlX0oxbCwXJn+xY3inbP7O3IXZpKjNH4CwiznfSCE2E3cKwczD9EfEnnNByX8eYzdlgAj9eZ4f5K77HMlrCQEiewGMoQbQhF3sBUnR25gAXLMuzxpkiboofav4KHieKDznxZhTVV0jGzCfgb+y3U00yd+8GII=" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="completed keyexchange" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=debug msg="completed challenge" Nov 03 23:58:01 volumio go-librespot[13792]: time="2025-11-03T23:58:01Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:04 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:04 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Nov 03 23:58:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:05 volumio go-librespot[13799]: go-librespot daemon starting... Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="app state loaded" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=info msg="zeroconf server listening on port 46687" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="obtained new client token: AABbNeeUbgoR+QVKs1627dEyQiVp16bGRQxG81k9ZeHbGppm+ES+h9KN4rWyiO1hJ2S4aOsCsvjL71jHg8F9P14Q79thpA/GMNuTGUXfISe7IW3RC4FMEvTU7RQ/oHUAMb8HMXewDMZeJoN6v2Q/KftLjDmcKTuftaSA17pjLR7GGN2N0EM1ZDSmHFHT3VFQ5XIeqYD6onE+yFqrfrbdMKEPTCQw8PFuS5klPa/UHecBasH+7gKj" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="completed keyexchange" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=debug msg="completed challenge" Nov 03 23:58:05 volumio go-librespot[13800]: time="2025-11-03T23:58:05Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:07 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:07 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Nov 03 23:58:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:08 volumio go-librespot[13822]: go-librespot daemon starting... Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="app state loaded" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=info msg="zeroconf server listening on port 44113" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="obtained new client token: AAD/PJI/UxtccgU1Tq4BH0ge8v3Fh94rvC6nLQC3zIgwTN/H0wsn6BivXJ8b22ec3vqb5arIKs3IJP2CRNuAFmKEYQFnwawFl8glTz7Caw1S70zp1SqWbIhiwf8yjANX5zIVozvUkgGX+hZLKMBpmwDGBl9YIMqn/Rylh4qd8cg1aDkO+GEgC2AlMtfqDJxvuVFvI1kxmmrZED0A51TgpT2R9jlQLfWqI/TrCMEm5aW9Cx3CvmDWPz4=" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="completed keyexchange" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=debug msg="completed challenge" Nov 03 23:58:08 volumio go-librespot[13823]: time="2025-11-03T23:58:08Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:08 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:08 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:10 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:10 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Nov 03 23:58:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:12 volumio go-librespot[13831]: go-librespot daemon starting... Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="app state loaded" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=info msg="zeroconf server listening on port 44423" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="obtained new client token: AABTyoBxodqbEK/+mv9haGyk7vRDKzR9dua5hH+3edqW40VtKmYjr5Q/HMoWHbSINInFuYF5JmW1ON/Vr+p6TWJAj/dr14Yr93uDKtRduNyDwvp2/z50AJultal/KINWMVWkiPF7d6/2HpF7iTYekTUwnrbZOghi5pCSHGt3gL+bAohXm9b6tsBCwYzkq0VdhPvOKjVbHCfiaUNtG4LvXkn1lpMuMCXFJ1mm2m4MJl36hTF4Voja" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="completed keyexchange" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=debug msg="completed challenge" Nov 03 23:58:12 volumio go-librespot[13832]: time="2025-11-03T23:58:12Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:13 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:13 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Nov 03 23:58:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:15 volumio go-librespot[13843]: go-librespot daemon starting... Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="app state loaded" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=info msg="zeroconf server listening on port 35897" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="obtained new client token: AACjgGLyKByvk3tPr0rBdTZ5NFqmYADx8u6nXHQ465M7g4j8E5EAb7EobFyzJCmWlcfEQnANlfzJUHq1rjJ14bJLIQNVYYG1PIi9osRdnJjVBRN6DAFBzG4OYFDyVRHm5ALLomK6xVe/IzxanqVVs5/muo8DetbDLOECJVZQXmlfkGaxvhdD0zLk9rzZks8svVqcTvP6A3jzZUTk+cz73y5ZfiNE0IITIIsJoj/pT6ckZ83WqFrdgZA=" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="completed keyexchange" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=debug msg="completed challenge" Nov 03 23:58:15 volumio go-librespot[13844]: time="2025-11-03T23:58:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:16 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:16 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Nov 03 23:58:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:19 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:19 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:19 volumio go-librespot[13866]: go-librespot daemon starting... Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="app state loaded" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=info msg="zeroconf server listening on port 33307" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="obtained new client token: AAAPticca1UTTASaxivlVh9c8trHx6nWMx0TrE7m2l22A1E+LLqKb5xdZyCGfKJbdgthSrSPS1e6HljikPbZ5sPqNLyHOTcWa3yqNDYhDoL2/rbxmevxY/ypyyVbm9/jd7JwfJ7w93hgQyT+6FvrfZzy4Ra8y5qOGG4tLlLePUJu9L3bM+h0tdhzYzblQr/fEjuj95hSSWfy0TCIwNT6fIrmVvG93Th9TwAgnI1kK880DmGI2oif" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="completed keyexchange" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=debug msg="completed challenge" Nov 03 23:58:19 volumio go-librespot[13867]: time="2025-11-03T23:58:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:22 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:22 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Nov 03 23:58:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:22 volumio go-librespot[13874]: go-librespot daemon starting... Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=debug msg="app state loaded" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=info msg="zeroconf server listening on port 36059" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=debug msg="obtained new client token: AAASFfphbh4ZSqJw8DaGIabzQEBZ59IswCllKI8gwTy9EkhhgvWqc59D+h2tBqkrICp+4GA8fcwnnl2zEL1xCRRD5g0ErHtBJbEjB177PojnHoNn7KPjLLuRhhLBpPDx2LksUywuUxMo1fYWXFry72fnKwblhuUFz24YIKL57vTT+XM0mVRqQY4Cvlx4sCqsvzXasaK4QuONYf04kJ8NfdKjxYlTp22q1zgv1WPG6x6tUqvotD8bdys=" Nov 03 23:58:22 volumio go-librespot[13875]: time="2025-11-03T23:58:22Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Nov 03 23:58:23 volumio go-librespot[13875]: time="2025-11-03T23:58:23Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:58:23 volumio go-librespot[13875]: time="2025-11-03T23:58:23Z" level=debug msg="completed keyexchange" Nov 03 23:58:23 volumio go-librespot[13875]: time="2025-11-03T23:58:23Z" level=debug msg="completed challenge" Nov 03 23:58:23 volumio go-librespot[13875]: time="2025-11-03T23:58:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:25 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:25 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Nov 03 23:58:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:26 volumio go-librespot[13885]: go-librespot daemon starting... Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="app state loaded" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=info msg="zeroconf server listening on port 41461" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="obtained new client token: AADgSP1i9fg6Lj21YzugxhJZm93mmCIKgtjPG5zkqIuer3Tif37eAVq+BVeyC2u+yLnj2gEUcMGSuvN2KXntHO3EcZnwfLVi3KlAstPBijd1O8eIlybrE3S4l43uXWV8dGDozKBPUWSo2vvALFpxKeOwUV3qNorQCRIK/zpm84ZmAw3JNnFwJrBRoxfUV1f/gaKHwyur2ZQaB99BKlL8qZPCoUDizkzbD84BQhQnhEfUCRvG2QF8jhQ=" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="completed keyexchange" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=debug msg="completed challenge" Nov 03 23:58:26 volumio go-librespot[13886]: time="2025-11-03T23:58:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:28 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:28 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Nov 03 23:58:29 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:29 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:29 volumio go-librespot[13908]: go-librespot daemon starting... Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="app state loaded" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=info msg="zeroconf server listening on port 46845" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="obtained new client token: AADqZL2N5IkFOT4vwHSSQPFxvzXoEqxky0Y9mdsW3NgkqZ+Wo9ZzFqJY68NGM4gyqS50xdeFjMNtJqBkTtWv4frGiJdSSzcPJoCz6IOJmP9uvFlclKbXjAhRRg/rCRvr+NZkUfuRnVDN8POBDaEPFHC4euwPaOAtzcUEyDfDzjF3h0MniQ2g4djAPLwhw+3m+sX1ZGzcAGINUmyxdSPUCQ2KhO37vn3GK+WMrlO5T04nYQlMHxKLMmM=" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58: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" Nov 03 23:58:29 volumio go-librespot[13909]: time="2025-11-03T23:58:29Z" level=debug msg="connected to ap-gew1.spotify.com:443" Nov 03 23:58:30 volumio go-librespot[13909]: time="2025-11-03T23:58:30Z" level=debug msg="completed keyexchange" Nov 03 23:58:30 volumio go-librespot[13909]: time="2025-11-03T23:58:30Z" level=debug msg="completed challenge" Nov 03 23:58:30 volumio go-librespot[13909]: time="2025-11-03T23:58:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:31 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:31 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Nov 03 23:58:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:33 volumio go-librespot[13917]: go-librespot daemon starting... Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="app state loaded" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=info msg="zeroconf server listening on port 43711" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="obtained new client token: AACsybSffimFAM2qxh97+bd1MlVliQPKxBtO4ICGaaEiIwGpX2ZjMp1ynsLJufjNdP81TCRU0ZDlJDfkcCi+4A2RQ72z9krN4gOMz/g3ALmG13m69UBv4re2pQOLEx64td3MPovqmhUFdkBoKTtRU/7o4oj191amJ6GY9qWDM9+2riztI8nIY89wynkah3FznnrXDTKAdccBEqeXIP2macvda4mxH0fHqqlpZAzRrAiP/fuYviIjTjw=" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="completed keyexchange" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=debug msg="completed challenge" Nov 03 23:58:33 volumio go-librespot[13918]: time="2025-11-03T23:58:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:34 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:34 volumio volumio[13130]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Nov 03 23:58:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 03 23:58:36 volumio go-librespot[13929]: go-librespot daemon starting... Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=info msg="running go-librespot 0.4.0" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="app state loaded" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=info msg="api server listening on 127.0.0.1:9879" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=info msg="zeroconf server listening on port 46239" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="obtained new client token: AABvLVyjfdDOI4jkfmXUOiZQnDAQ1AlkzqPPvBtvqbQNKu56ONqWb6UiyALJqjgsN0yzQrP4S4WfgVqZiGTN4D6prSHnEo301pe+StnjfwtiKYVPTwbu2L3vXNnoIuzIOydzsGYn1Q/i/U7rvvLoFsZ/6J8E38jKviEpFin6qEkyZoNKRyMktT4ZF4YoIgKDdTeluh9oAdNFs7wYXWPkyDwTqxa6hEHI9xxw2IXGzy2ixIEDXrC07rI=" Nov 03 23:58:36 volumio go-librespot[13930]: time="2025-11-03T23:58:36Z" level=debug msg="connected to ap-gew1.spotify.com:4070" Nov 03 23:58:37 volumio go-librespot[13930]: time="2025-11-03T23:58:37Z" level=debug msg="completed keyexchange" Nov 03 23:58:37 volumio go-librespot[13930]: time="2025-11-03T23:58:37Z" level=debug msg="completed challenge" Nov 03 23:58:37 volumio volumio[13130]: info: Initializing connection to go-librespot Websocket Nov 03 23:58:37 volumio volumio[13130]: info: Connection to go-librespot Websocket established Nov 03 23:58:37 volumio go-librespot[13930]: time="2025-11-03T23:58:37Z" level=debug msg="new websocket client" Nov 03 23:58:37 volumio go-librespot[13930]: time="2025-11-03T23:58:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction " Nov 03 23:58:37 volumio volumio[13130]: info: Connection to go-librespot Websocket closed Nov 03 23:58:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 03 23:58:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 03 23:58:40 volumio volumio[13130]: info: Getting Spotify volume Nov 03 23:58:40 volumio volumio[13130]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 23:58:40 volumio volumio[13130]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 03 23:58:40 volumio volumio[13130]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 03 23:58:40 volumio volumio[13130]: errno: -111, Nov 03 23:58:40 volumio volumio[13130]: code: 'ECONNREFUSED', Nov 03 23:58:40 volumio volumio[13130]: syscall: 'connect', Nov 03 23:58:40 volumio volumio[13130]: address: '127.0.0.1', Nov 03 23:58:40 volumio volumio[13130]: port: 9879, Nov 03 23:58:40 volumio volumio[13130]: response: undefined Nov 03 23:58:40 volumio volumio[13130]: } Nov 03 23:58:40 volumio volumio[13130]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 23:58:40 volumio sudo[13965]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-03 23:57' Nov 03 23:58:40 volumio sudo[13965]: 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"