-- Logs begin at Sat 2026-04-11 05:50:00 UTC, end at Sat 2026-04-11 07:59:47 UTC. -- Apr 11 07:58:00 volumio volumio[698]: ------------------------------------ BT MESSAGE: BT STATUS: paused Apr 11 07:58:00 volumio volumio[698]: BT PLUGIN MESSAGE: Playing: false Apr 11 07:58:00 volumio volumio[698]: BT PLUGIN MESSAGE: VOLATILE: bluetooth Apr 11 07:58:00 volumio volumio[698]: BT PLUGIN MESSAGE: STATE:undefined Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:00 volumio volumio[698]: verbose: UNSET VOLATILE: Service: bluetooth Apr 11 07:58:00 volumio volumio[698]: info: Bluetooth Detach Command Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::resetVolumioState Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::getcurrentVolume Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioStop Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::stop Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:00 volumio volumio[698]: info: CorePlayQueue::getTrack 0 Apr 11 07:58:00 volumio volumio[698]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received bluetooth Apr 11 07:58:00 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:00 volumio volumio[698]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 11 07:58:00 volumio volumio[698]: info: Bluetooth Audio successfully Disabled Apr 11 07:58:00 volumio volumio[698]: info: Bluetooth Successfully Detached Apr 11 07:58:00 volumio volumio[698]: info: VolumeController:: Volume=74 Mute =false Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:00 volumio volumio[698]: info: CorePlayQueue::getTrack 0 Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::updateTrackBlock Apr 11 07:58:00 volumio volumio[698]: info: CorePlayQueue::getTrackBlock Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 07:58:00 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:00 volumio volumio[698]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 07:58:00 volumio volumio[698]: info: VolumeController:: Volume=74 Mute =false Apr 11 07:58:00 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:00 volumio volumio[698]: info: CorePlayQueue::getTrack 0 Apr 11 07:58:00 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:00 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:00 volumio volumio[698]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 11 07:58:00 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:02 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:02 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299767. Apr 11 07:58:02 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:02 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:02 volumio go-librespot[28648]: Librespot-go daemon starting... Apr 11 07:58:02 volumio go-librespot[28648]: time="2026-04-11T07:58:02Z" level=info msg="generated new device id: 7dbd4cf4d0ffbfc6127b2d68fa0c8ad3e6c51f8f" Apr 11 07:58:02 volumio go-librespot[28648]: time="2026-04-11T07:58:02Z" level=debug msg="obtained new client token: AACVYkMIYGuZtIIlguaiU96s6frTJtnvBfZTco5MlPnMuZiM5BgaOHVozE3Qhlag6b+zzEtk0D4A9yRWVfFw2qm9RmMhR8JwU7ua4UF4LSwGplNQBG1eNvMXGfAlYPLFRmvMidGXqmGmJI31qZLoJbP5SN4Dv7kFkU8IaS6n1QbhjQBxjsKdn1Xb7X1/Z6VzUHVKid/8O07lUs4yWh7GDWdEPyUskVYrk9ikOO0Zc8qwYyejHB1KbuZkIQJKkdgR" Apr 11 07:58:02 volumio go-librespot[28648]: time="2026-04-11T07:58:02Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:02 volumio go-librespot[28648]: time="2026-04-11T07:58:02Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:03 volumio go-librespot[28648]: time="2026-04-11T07:58:03Z" level=debug msg="completed keyexchange" Apr 11 07:58:03 volumio go-librespot[28648]: time="2026-04-11T07:58:03Z" level=debug msg="completed challenge" Apr 11 07:58:03 volumio go-librespot[28648]: time="2026-04-11T07:58:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:05 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:05 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:06 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299768. Apr 11 07:58:06 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:06 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:06 volumio go-librespot[28656]: Librespot-go daemon starting... Apr 11 07:58:06 volumio go-librespot[28656]: time="2026-04-11T07:58:06Z" level=info msg="generated new device id: df4f29ae6a30a6a303cc15c781ec4f7039dd0b82" Apr 11 07:58:06 volumio go-librespot[28656]: time="2026-04-11T07:58:06Z" level=debug msg="obtained new client token: AAA4OFwRWryMZuYWkwC5ssaLYjvbAujA13+XMkRCHFTgoOWKD9SaMLfhgFEh2UdesUQhCNiLOdCF0nn6d/3ELHu5FC1EnsdYt8+iFDL0nRL367tUtPpwyyE6Mw4S2I+vW72nSJkXrOuKWc5KvPlBwNn0QMh1wEuWW5yPpwGx3nrs5tEUggfFR0OYV4x7mCPJqUAi52b1uxf0OVPkuJAT3r+WXGuTk3UDJtG+0GAHiVoNTkgDoeFU+odHFa0QgxaR" Apr 11 07:58:06 volumio go-librespot[28656]: time="2026-04-11T07:58:06Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:06 volumio go-librespot[28656]: time="2026-04-11T07:58:06Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:07 volumio go-librespot[28656]: time="2026-04-11T07:58:07Z" level=debug msg="completed keyexchange" Apr 11 07:58:07 volumio go-librespot[28656]: time="2026-04-11T07:58:07Z" level=debug msg="completed challenge" Apr 11 07:58:07 volumio go-librespot[28656]: time="2026-04-11T07:58:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:08 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:08 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:10 volumio volumio[698]: ------------------------------------ BT MESSAGE: BT STATUS: pending Apr 11 07:58:10 volumio volumio[698]: ------------------------------------ BT MESSAGE: BT STATUS: active Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: Playing: true Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: VOLATILE: undefined Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: STATE:undefined Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::volumioStop Apr 11 07:58:10 volumio volumio[698]: info: CoreStateMachine::stop Apr 11 07:58:10 volumio volumio[698]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: BLUETOOTH: Starting Playback Routine Apr 11 07:58:10 volumio volumio[698]: info: Enabling Bluetooth Audio Output Apr 11 07:58:10 volumio pulseaudio[1863]: Cannot set requested source latency of 66.67 ms, adjusting to 135.29 ms Apr 11 07:58:10 volumio pulseaudio[1863]: Configured latency of 200.00 ms is smaller than minimum latency, using minimum instead Apr 11 07:58:10 volumio pulseaudio[1863]: Cannot set requested sink latency of 337.51 ms, adjusting to 600.00 ms Apr 11 07:58:10 volumio volumio[698]: info: Bluetooth Audio successfully Enabled Apr 11 07:58:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299769. Apr 11 07:58:10 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:10 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:10 volumio go-librespot[28671]: Librespot-go daemon starting... Apr 11 07:58:10 volumio go-librespot[28671]: time="2026-04-11T07:58:10Z" level=info msg="generated new device id: 94898264fbf9fd3d78bf9cabcb70364352a625e5" Apr 11 07:58:10 volumio volumio[698]: ------------------------------------ BT MESSAGE: BT STATUS: playing Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: Playing: true Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: VOLATILE: bluetooth Apr 11 07:58:10 volumio volumio[698]: BT PLUGIN MESSAGE: STATE:undefined Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:10 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:10 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:10 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:10 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:10 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:10 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:10 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:10 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:10 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:10 volumio go-librespot[28671]: time="2026-04-11T07:58:10Z" level=debug msg="obtained new client token: AAAeeNxgKPBFQy9wmnvYdJ7VD00yEGmSerq5Icj8ZoCVrm8LfraxJm9/z5P0X+AMxwiVSGuaX83QswsvxOqbJ3leWYMu2MGjowZHS9GjpyCX5cn+4ThGnGxoSm5MLNTXzIuOS2lbmcfQqOvLg3+BqsO1GLnFADtkYWWc8tMAlthaX6akJb7JJggmXN+dkNjVtqxCCF8Asoy0HdFsvriUyoLJnet3eXumLCXAI8iar7DQrTLLevR8Yo+pvmEID3u7" Apr 11 07:58:10 volumio go-librespot[28671]: time="2026-04-11T07:58:10Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:10 volumio pulseaudio[1863]: Too many underruns, increasing latency to 815.32 ms Apr 11 07:58:11 volumio go-librespot[28671]: time="2026-04-11T07:58:11Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:11 volumio go-librespot[28671]: time="2026-04-11T07:58:11Z" level=debug msg="completed keyexchange" Apr 11 07:58:11 volumio go-librespot[28671]: time="2026-04-11T07:58:11Z" level=debug msg="completed challenge" Apr 11 07:58:11 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:11 volumio go-librespot[28671]: time="2026-04-11T07:58:11Z" level=debug msg="new websocket client" Apr 11 07:58:11 volumio volumio[698]: info: Connection to go-librespot Websocket established Apr 11 07:58:11 volumio go-librespot[28671]: time="2026-04-11T07:58:11Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:11 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:11 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:11 volumio volumio[698]: info: Connection to go-librespot Websocket closed Apr 11 07:58:14 volumio volumio[698]: info: Getting Spotify volume Apr 11 07:58:14 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:14 volumio volumio[698]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 11 07:58:14 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 133711) Apr 11 07:58:14 volumio volumio[698]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 11 07:58:14 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:14 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:14 volumio volumio[698]: info: CoreCommandRouter::volumioGetState Apr 11 07:58:14 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:14 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299770. Apr 11 07:58:14 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:14 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:14 volumio go-librespot[28679]: Librespot-go daemon starting... Apr 11 07:58:14 volumio go-librespot[28679]: time="2026-04-11T07:58:14Z" level=info msg="generated new device id: 10c57f2768bc22d4d052eb07c54e67d7510ff483" Apr 11 07:58:14 volumio go-librespot[28679]: time="2026-04-11T07:58:14Z" level=debug msg="obtained new client token: AABgHKFypbSbcE4q3gXModdaUeSIhTnvM/zGxShxoTieWMZGH8P7CA6s3J1e18TFhxJadbDIFytjCRAHoF7c0lmPhcvqwHncfz8rZimbmsJLd6LAkZlcu2xK/obOQ61SJ590QGIHw4LjIntvb4DBDrl6KbeP55puh7VTglkv+t9EzSFWhOPJ0LAPaG0pj1tJw36Cvn2Ox3nLMqVfnipLmW4l15QnobzXQmwJyU/qiLdwD0dpNbu1YrBt7fuXDGlg" Apr 11 07:58:14 volumio go-librespot[28679]: time="2026-04-11T07:58:14Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:14 volumio go-librespot[28679]: time="2026-04-11T07:58:14Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 11 07:58:15 volumio go-librespot[28679]: time="2026-04-11T07:58:15Z" level=debug msg="completed keyexchange" Apr 11 07:58:15 volumio go-librespot[28679]: time="2026-04-11T07:58:15Z" level=debug msg="completed challenge" Apr 11 07:58:15 volumio go-librespot[28679]: time="2026-04-11T07:58:15Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:17 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:17 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:18 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299771. Apr 11 07:58:18 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:18 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:18 volumio go-librespot[28687]: Librespot-go daemon starting... Apr 11 07:58:18 volumio go-librespot[28687]: time="2026-04-11T07:58:18Z" level=info msg="generated new device id: a78286c7ae6fdb04cf55abde98999e2cfe71fd39" Apr 11 07:58:18 volumio go-librespot[28687]: time="2026-04-11T07:58:18Z" level=debug msg="obtained new client token: AADBPcH+OeF9L/epGiIZQ0o0IK+P7sHd4UK2DekB/sNzXGJG/ODtp8pKbu3xk9D1fIPfdIacHSgM+CCQ27n4JqsVHtvNk1LTZkBMjlqoqp+d61fY5bn1hBCBw1DyVY40rQ2u9GcR1TKVx6kDHvgPrPdBjPWxVb6MsKVENjqRdw2CcAafUjrrFUe6hcTdLb14yqWc+UnQvdJZWdHIYbx+0q6XBeRt9DVaNKG+xQhNgBSExagJO8y6rt4mqCQuHrOa" Apr 11 07:58:18 volumio go-librespot[28687]: time="2026-04-11T07:58:18Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:18 volumio go-librespot[28687]: time="2026-04-11T07:58:18Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:19 volumio go-librespot[28687]: time="2026-04-11T07:58:19Z" level=debug msg="completed keyexchange" Apr 11 07:58:19 volumio go-librespot[28687]: time="2026-04-11T07:58:19Z" level=debug msg="completed challenge" Apr 11 07:58:19 volumio go-librespot[28687]: time="2026-04-11T07:58:19Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:20 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:20 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:22 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299772. Apr 11 07:58:22 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:22 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:22 volumio go-librespot[28695]: Librespot-go daemon starting... Apr 11 07:58:22 volumio go-librespot[28695]: time="2026-04-11T07:58:22Z" level=info msg="generated new device id: a5cd5057b8edb312bccc6eaca7290c2803bb1d8d" Apr 11 07:58:22 volumio go-librespot[28695]: time="2026-04-11T07:58:22Z" level=debug msg="obtained new client token: AAC2jhcAHpN9/NSERCGsFXGn92xwpdf5IOib0zql7JzQ8tXkx9V1z5Vi9eCEgf28vsEKDlzcawDoiOUVh/k2sKR0Mcw0QeOa3Q/BI35QKa57nil+9yyC4VZVrDwBSmxhHS1afHOIgel+SMSvWbNjIF6D1YRgRYujQZjqv7Kto4j0IbVxQbd0jvYJzFNVw07hfE19L4mAug8rm1/NVgQ2svhgQC04sPJ6esAQMyoNjuJpvkJ4g9tBGz8dQXNnCzj2" Apr 11 07:58:22 volumio go-librespot[28695]: time="2026-04-11T07:58:22Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:22 volumio go-librespot[28695]: time="2026-04-11T07:58:22Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:23 volumio go-librespot[28695]: time="2026-04-11T07:58:23Z" level=debug msg="completed keyexchange" Apr 11 07:58:23 volumio go-librespot[28695]: time="2026-04-11T07:58:23Z" level=debug msg="completed challenge" Apr 11 07:58:23 volumio go-librespot[28695]: time="2026-04-11T07:58:23Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:23 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:23 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:26 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:26 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:26 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299773. Apr 11 07:58:26 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:26 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:26 volumio go-librespot[28703]: Librespot-go daemon starting... Apr 11 07:58:26 volumio go-librespot[28703]: time="2026-04-11T07:58:26Z" level=info msg="generated new device id: 8eb9d46b79f48bdd3d79e582ab0d2d99f185d20e" Apr 11 07:58:26 volumio go-librespot[28703]: time="2026-04-11T07:58:26Z" level=debug msg="obtained new client token: AAAlIrHo6T7S+64w1f5E5ZSKZcFmn5Vte9veZ57XYmMrgS+1mYmSX1IYXujyAQqXwRwMCkYlgqSeIuecS7jW/2QVmauZod3QC4rEPF9yFog5WL3pTbKZaheyzoqmNpJvkPhxshyMmddQ3Z2QyDk5LGUwTTqRl4yDQIffTHOthcY+1QH9N5EMrwdmnqKLH3B7S3ZFlFgihWXnxixgS2pTNv0xfBQEs8IyRHohoc4R+JlCD6yju4yy5dZBVkq3VXs6" Apr 11 07:58:26 volumio go-librespot[28703]: time="2026-04-11T07:58:26Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:26 volumio go-librespot[28703]: time="2026-04-11T07:58:26Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:27 volumio go-librespot[28703]: time="2026-04-11T07:58:27Z" level=debug msg="completed keyexchange" Apr 11 07:58:27 volumio go-librespot[28703]: time="2026-04-11T07:58:27Z" level=debug msg="completed challenge" Apr 11 07:58:27 volumio go-librespot[28703]: time="2026-04-11T07:58:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:29 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:29 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:30 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299774. Apr 11 07:58:30 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:30 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:30 volumio go-librespot[28712]: Librespot-go daemon starting... Apr 11 07:58:30 volumio go-librespot[28712]: time="2026-04-11T07:58:30Z" level=info msg="generated new device id: 946c8ee951bf340d8c70eeadfe42c7c288928b8f" Apr 11 07:58:30 volumio go-librespot[28712]: time="2026-04-11T07:58:30Z" level=debug msg="obtained new client token: AAA3Rx0y6l0q9tUW2OTxClU/TFzBmEbjF9KqYrV/BQGW0hvsfXnboz+E50kM2hNYAGczF8bxMqdcgkq4NfSsXnrLiR0YUp7cGvDCGNA2MYtZQkwuvh55AoR20C0HRV/vUHVLEWDUAYdFQ3ePtgmK36SBV8E7F4oiUoup98nwU4ESS8WXRA1aR/twvvFTTFJbkTch+bY3fdKPbsU9Gzuks8lXdmYYQXICCklyt2lj6Wdtwd67Rxyc5RO7Bqnt61CY" Apr 11 07:58:30 volumio go-librespot[28712]: time="2026-04-11T07:58:30Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:30 volumio go-librespot[28712]: time="2026-04-11T07:58:30Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 11 07:58:31 volumio go-librespot[28712]: time="2026-04-11T07:58:31Z" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.1.133:4070: connect: connection refused" Apr 11 07:58:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:32 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:32 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:34 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299775. Apr 11 07:58:34 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:34 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:34 volumio go-librespot[28720]: Librespot-go daemon starting... Apr 11 07:58:34 volumio go-librespot[28720]: time="2026-04-11T07:58:34Z" level=info msg="generated new device id: 8562d2eb8fdeded856970d3a0fb392714fe0c0cd" Apr 11 07:58:34 volumio go-librespot[28720]: time="2026-04-11T07:58:34Z" level=debug msg="obtained new client token: AAAi1KgUbh+L75AuQ3pYiK9Dji8DgWFNZ/5JfSnUKo3rUQBP0wQ5alV40M4RHnzlovc+nY8/5HR50JcFmtVSERWz0gl17YIUPnzNtdk6jh6UlGZcX9+dZCVpGxLHB6Xp3HpDYAi5AV+PbRfkj8yA7caSyUWhk4SSUJfW3WL4BqhCUXVf+u/HcGcDhtF9cIq15P4RLcZVzI69d8Nj1S8GGpj9TTP/NisTzetb5Hjj+UhsAYKBgOHzJy6RwEQKnaWI" Apr 11 07:58:34 volumio go-librespot[28720]: time="2026-04-11T07:58:34Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:34 volumio go-librespot[28720]: time="2026-04-11T07:58:34Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:34 volumio go-librespot[28720]: time="2026-04-11T07:58:34Z" level=debug msg="completed keyexchange" Apr 11 07:58:35 volumio go-librespot[28720]: time="2026-04-11T07:58:35Z" level=debug msg="completed challenge" Apr 11 07:58:35 volumio go-librespot[28720]: time="2026-04-11T07:58:35Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:35 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:35 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:38 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299776. Apr 11 07:58:38 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:38 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:38 volumio go-librespot[28728]: Librespot-go daemon starting... Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=info msg="generated new device id: 14bb9ef231c0f8a841bd4ec056b5f5a7b8ff8b12" Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=debug msg="obtained new client token: AAASWRa//LsK7n9E8Ql+FAQAZeglivjBjIS+uQdyoFFc7h3O1SZVduDg3cCgzTJI4hqhkRHLysmz7Txh7aK84yhfjAEP8AhQXvccwUzfzBDK51kAjqwqYkmPes9NQ7sY/RLlgz+K1gi0IZOkBm86/Tm4lj98bYFUXGp4DSERms/CqEpB9J0z9twY+LtE3/TFs1lcmolk6n98B0gkvnVji41NgtL9WrMLyNb8Rf/p84DEWd/YkJib2BmUgTTfhQuD" Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=debug msg="completed keyexchange" Apr 11 07:58:38 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:38 volumio volumio[698]: info: Connection to go-librespot Websocket established Apr 11 07:58:38 volumio go-librespot[28728]: time="2026-04-11T07:58:38Z" level=debug msg="new websocket client" Apr 11 07:58:39 volumio go-librespot[28728]: time="2026-04-11T07:58:39Z" level=debug msg="completed challenge" Apr 11 07:58:39 volumio go-librespot[28728]: time="2026-04-11T07:58:39Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:39 volumio volumio[698]: info: Connection to go-librespot Websocket closed Apr 11 07:58:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:41 volumio volumio[698]: info: Getting Spotify volume Apr 11 07:58:41 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:41 volumio volumio[698]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 11 07:58:41 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 133712) Apr 11 07:58:41 volumio volumio[698]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 11 07:58:41 volumio volumio[698]: info: CoreCommandRouter::volumioGetState Apr 11 07:58:41 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:42 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:42 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:42 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:42 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299777. Apr 11 07:58:42 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:42 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:42 volumio go-librespot[28737]: Librespot-go daemon starting... Apr 11 07:58:42 volumio go-librespot[28737]: time="2026-04-11T07:58:42Z" level=info msg="generated new device id: 65e7f05b8e35b999b5f08915c63ad98e3d7f5237" Apr 11 07:58:42 volumio go-librespot[28737]: time="2026-04-11T07:58:42Z" level=debug msg="obtained new client token: AAD3hK2p+yDQzvEjaQP8uAJpkCb6Z+LS/7Vm3TqDjzOH5zi/7CQmccXFn0ChB7TL2DRHhCA5p165zUjuqMKxNHdc/dWZTAhRlJhNt/1C3h+fba7iawXb+WNin7MIGIXOqjiwRBm1O9hCFLeR3R6FIfXOVeZfbSCasHzlEC0Kj7daHOrVHrlEbyL/A2sv/1k/HsaqnTdJIqliBStTiCt1uHXqEpp5fj46jvGQaIdCZBF+oVl+3qr9gJGM8NYvLd4E" Apr 11 07:58:42 volumio go-librespot[28737]: time="2026-04-11T07:58:42Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:42 volumio go-librespot[28737]: time="2026-04-11T07:58:42Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:42 volumio go-librespot[28737]: time="2026-04-11T07:58:42Z" level=debug msg="completed keyexchange" Apr 11 07:58:43 volumio go-librespot[28737]: time="2026-04-11T07:58:43Z" level=debug msg="completed challenge" Apr 11 07:58:43 volumio go-librespot[28737]: time="2026-04-11T07:58:43Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:45 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:45 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:46 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299778. Apr 11 07:58:46 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:46 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:46 volumio go-librespot[28746]: Librespot-go daemon starting... Apr 11 07:58:46 volumio go-librespot[28746]: time="2026-04-11T07:58:46Z" level=info msg="generated new device id: 58c13270db70018bebe5922db02d4a31f9b30fa2" Apr 11 07:58:46 volumio go-librespot[28746]: time="2026-04-11T07:58:46Z" level=debug msg="obtained new client token: AAAK0GDXYqVWs6MDZ/vVjC8Yf9PQeZMJnXQZUE5SOUTt6wJV50btu+sRM9p2xFBBQdMUMXwRdZNijSctKNPhA79prjOPK/ACkcIkaJv/yb52Y3AHS5HcKFdK9MCu9s6qAqdP6v2cJrcla1rdP/cOpzvMzndLQEGR4gbdptvcEG2zjBIkaq6cGu2jFcqQpt0jbqerm42Xpira7kt6subm3W47ELOJbt0o0TVQgB3YPL4jtE8+BNlRnCYajZxx/3t5" Apr 11 07:58:46 volumio go-librespot[28746]: time="2026-04-11T07:58:46Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:46 volumio go-librespot[28746]: time="2026-04-11T07:58:46Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:46 volumio go-librespot[28746]: time="2026-04-11T07:58:46Z" level=debug msg="completed keyexchange" Apr 11 07:58:47 volumio go-librespot[28746]: time="2026-04-11T07:58:47Z" level=debug msg="completed challenge" Apr 11 07:58:47 volumio go-librespot[28746]: time="2026-04-11T07:58:47Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:47 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:47 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:48 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:48 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:48 volumio volumio[698]: BT PLUGIN MESSAGE: Duration is 21570002 Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:48 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:48 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:48 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:48 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:48 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:48 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:48 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:48 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:48 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 11 07:58:50 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:50 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299779. Apr 11 07:58:50 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:50 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:50 volumio go-librespot[28755]: Librespot-go daemon starting... Apr 11 07:58:50 volumio go-librespot[28755]: time="2026-04-11T07:58:50Z" level=info msg="generated new device id: 59c52e3af26a164b85a1cc5e67fc046ca189e804" Apr 11 07:58:50 volumio go-librespot[28755]: time="2026-04-11T07:58:50Z" level=debug msg="obtained new client token: AACcp/ymGqS84nn8Av0NKQwvmYQM0CrFHi99gUBes0yuWPtMt610Og22VDsKYU43ojiNuMeYdVc+Xb0MG4DwiqQbGMLgZLCCUh0oSeDI85VL9j1DtlmP3wFiJ52WEiqs/wKNN8WHO4lyPhkB4TqVADwY1zydWtHNZQ6rDt54kOuuOi8lzhvRmvvgr6HRqZ4H14qokqT4+fynUehmvRdXGCtavAiNzMNFczKW9UN5C9pC8nDLa+lVHPs9JVIv5nSH" Apr 11 07:58:50 volumio go-librespot[28755]: time="2026-04-11T07:58:50Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:50 volumio go-librespot[28755]: time="2026-04-11T07:58:50Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 11 07:58:50 volumio go-librespot[28755]: time="2026-04-11T07:58:50Z" level=debug msg="completed keyexchange" Apr 11 07:58:51 volumio go-librespot[28755]: time="2026-04-11T07:58:51Z" level=debug msg="completed challenge" Apr 11 07:58:51 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:51 volumio go-librespot[28755]: time="2026-04-11T07:58:51Z" level=debug msg="new websocket client" Apr 11 07:58:51 volumio volumio[698]: info: Connection to go-librespot Websocket established Apr 11 07:58:51 volumio go-librespot[28755]: time="2026-04-11T07:58:51Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:51 volumio volumio[698]: info: Connection to go-librespot Websocket closed Apr 11 07:58:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:52 volumio volumio[698]: info: VolumeController::SetAlsaVolume93 Apr 11 07:58:52 volumio volumio[698]: BT PLUGIN MESSAGE: Volume set to 93 Apr 11 07:58:52 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:52 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:52 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:52 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:52 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:52 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:58:52 volumio volumio[698]: SPOTIFY: SPOTIFY VOLUME 74 Apr 11 07:58:52 volumio volumio[698]: SPOTIFY: VOLUMIO VOLUME 93 Apr 11 07:58:52 volumio volumio[698]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 11 07:58:52 volumio volumio[698]: info: Setting Spotify Volume from Volumio: 93 Apr 11 07:58:52 volumio volumio[698]: SPOTIFY: SETTING SPOTIFY VOLUME 93 Apr 11 07:58:52 volumio volumio[698]: info: Sending Spotify command with payload to local API: /player/volume Apr 11 07:58:52 volumio volumio[698]: error: Failed to send command to Spotify local API: /player/volume: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:54 volumio volumio[698]: info: Getting Spotify volume Apr 11 07:58:54 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:54 volumio volumio[698]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) Apr 11 07:58:54 volumio volumio[698]: (node:698) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 133713) Apr 11 07:58:54 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:54 volumio volumio[698]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Apr 11 07:58:54 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:54 volumio volumio[698]: info: CoreCommandRouter::volumioGetState Apr 11 07:58:54 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:58:54 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299780. Apr 11 07:58:54 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:54 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:54 volumio go-librespot[28764]: Librespot-go daemon starting... Apr 11 07:58:54 volumio go-librespot[28764]: time="2026-04-11T07:58:54Z" level=info msg="generated new device id: 5bb0db0acd535aa6b1b4226638b895be356ad39a" Apr 11 07:58:54 volumio go-librespot[28764]: time="2026-04-11T07:58:54Z" level=debug msg="obtained new client token: AAAWA24EP0lNd+dC4Cq+uw38M5of8p6Rlx3G3tbIRkPC29NSAiWid1LYVo9uFPT5e0+IYvKkT/LgIuPKTNzTLQav4P0q+jQQcxr5c4jbwgjVBfjY1DPxMXsgxlgLEd202c3N/l+CA204tmGu6ZoDgir36sjJ33vESRcdww8UabDn9LXYOzscsDbHwVn79pIJYiVQQGt2bxWGBju2OX7exe38GUMFgkmDF9BhXqwDUrOJ1Z6l6xM8Q0bAShChikZv" Apr 11 07:58:54 volumio go-librespot[28764]: time="2026-04-11T07:58:54Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:54 volumio go-librespot[28764]: time="2026-04-11T07:58:54Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:54 volumio go-librespot[28764]: time="2026-04-11T07:58:54Z" level=debug msg="completed keyexchange" Apr 11 07:58:55 volumio go-librespot[28764]: time="2026-04-11T07:58:55Z" level=debug msg="completed challenge" Apr 11 07:58:55 volumio go-librespot[28764]: time="2026-04-11T07:58:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:58:57 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:58:57 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:58:58 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:58:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299781. Apr 11 07:58:58 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:58:58 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:58:58 volumio go-librespot[28772]: Librespot-go daemon starting... Apr 11 07:58:58 volumio go-librespot[28772]: time="2026-04-11T07:58:58Z" level=info msg="generated new device id: 3b10481dbf0b858113d9d6e2d1d59efb4b3743e9" Apr 11 07:58:58 volumio go-librespot[28772]: time="2026-04-11T07:58:58Z" level=debug msg="obtained new client token: AADeAhwpmV5c1g0ZzOnsnIN9Ud0Iu8pSNVRoU0h19saUF8eROlwNfnnTR2IK4kOOOWP/Kc22Js54UWvtIGpVBkParCVYbUctIw+jXjad6DMFGByTXXH53TY2mtA5/TNhe+ehS8YsmE02Klu8VMiuyQv6NaoUkEvb/pbfsCRlFP1ZAn+8xwsvauxRC6nfaVjL1Wt7ONnjMYGIpJXwhbjtIfem/AVZxcfzIHNRad7lPgDgt3rcLP9HYqs1VBskwpUR" Apr 11 07:58:58 volumio go-librespot[28772]: time="2026-04-11T07:58:58Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:58:58 volumio go-librespot[28772]: time="2026-04-11T07:58:58Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:58:58 volumio go-librespot[28772]: time="2026-04-11T07:58:58Z" level=debug msg="completed keyexchange" Apr 11 07:58:58 volumio volumio[698]: BT PLUGIN MESSAGE: Duration is 21570002 Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:58 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:58 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:58 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:58 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:58:58 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:58:58 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:58:58 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:58:58 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:58:58 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:58:59 volumio go-librespot[28772]: time="2026-04-11T07:58:59Z" level=debug msg="completed challenge" Apr 11 07:58:59 volumio go-librespot[28772]: time="2026-04-11T07:58:59Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:58:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:58:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:00 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:00 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:02 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299782. Apr 11 07:59:02 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:02 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:02 volumio go-librespot[28780]: Librespot-go daemon starting... Apr 11 07:59:02 volumio go-librespot[28780]: time="2026-04-11T07:59:02Z" level=info msg="generated new device id: 4cd6ea088688e57f133e2e688f060524b05c39f8" Apr 11 07:59:02 volumio go-librespot[28780]: time="2026-04-11T07:59:02Z" level=debug msg="obtained new client token: AAAO56IWEbj23DQlP3kWo28njw897QDACOIsbEvVMVpM8W6ZSYBqLiRsvM8tlMUDqzT3dZXjH24mgSJf8/fqGZKE5DFhhg9tYWg/rUOTQgo1aR9IkGhZVS3E9QpfYlmpcIUS8ixcY+XLaKeJ2IkkCE3vY5m5kq2iGdoBQl6iN2dF13kkSy0Fqst2TWuH+hC1+qnlqQdPILFwV4tWxZGwUOjmJnAP3GRLOQGXaiNbPQePImfnFT6Fynxi1/Vls3dX" Apr 11 07:59:02 volumio go-librespot[28780]: time="2026-04-11T07:59:02Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:02 volumio go-librespot[28780]: time="2026-04-11T07:59:02Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:02 volumio go-librespot[28780]: time="2026-04-11T07:59:02Z" level=debug msg="completed keyexchange" Apr 11 07:59:03 volumio go-librespot[28780]: time="2026-04-11T07:59:03Z" level=debug msg="completed challenge" Apr 11 07:59:03 volumio go-librespot[28780]: time="2026-04-11T07:59:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:03 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:03 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:06 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:06 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:06 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299783. Apr 11 07:59:06 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:06 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:06 volumio go-librespot[28788]: Librespot-go daemon starting... Apr 11 07:59:06 volumio go-librespot[28788]: time="2026-04-11T07:59:06Z" level=info msg="generated new device id: c20b5b83e44f071625f5eb7586262d1ff56a1469" Apr 11 07:59:06 volumio go-librespot[28788]: time="2026-04-11T07:59:06Z" level=debug msg="obtained new client token: AADPDagm8dz1WUDTtd3lbRdrg6VkGgug0S7FOFB/JHwU/rrsj9GXJLILsYPrZg9RyF+wp8ojwP9q5CLPW8/2qcDefV8mPCmmluLJKybX8fgMHOcc+wnl1KSF0GpGm23r24F7CxeV7VQUuPOPni5LGdZyclzYsHU6+VyEElBV9ScEXXDu29cG8bSGtcGu+ENi5uud5hfueLigLSRDvci14R5AhiDqFqf8qfy4bPMThHALAtlFAkPc2S0boYzAhZOt" Apr 11 07:59:06 volumio go-librespot[28788]: time="2026-04-11T07:59:06Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:06 volumio go-librespot[28788]: time="2026-04-11T07:59:06Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:06 volumio go-librespot[28788]: time="2026-04-11T07:59:06Z" level=debug msg="completed keyexchange" Apr 11 07:59:07 volumio go-librespot[28788]: time="2026-04-11T07:59:07Z" level=debug msg="completed challenge" Apr 11 07:59:07 volumio go-librespot[28788]: time="2026-04-11T07:59:07Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:09 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:09 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:10 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299784. Apr 11 07:59:10 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:10 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:10 volumio go-librespot[28800]: Librespot-go daemon starting... Apr 11 07:59:10 volumio go-librespot[28800]: time="2026-04-11T07:59:10Z" level=info msg="generated new device id: 54e4b5f7fa6a77804aa1d1338e5c0cebbb422956" Apr 11 07:59:10 volumio go-librespot[28800]: time="2026-04-11T07:59:10Z" level=debug msg="obtained new client token: AAA1me7SgXk7a+mrTfpabye/f/F7+4EwYoZ8t4IKzpZgEA9CJ3TqoEQKyfcQ1hCW5/YXCrqXyKU06mqEoiMrKvXL7OeDItYnfWMAwmqwt27cb1Vrs9cgDOltbFh7NYDfg9iF/xz+UI0kLOcaRhHaY6QYl12En6TVCFUwq8vkqJo9fjD79tsyMucV/WZJXwDj0vpdQANiJqOIzPUf5/eJvThsl6r3sOGox7fYEJ83mkOtlB7sRpOMSbPrlAlGoU5w" Apr 11 07:59:10 volumio go-librespot[28800]: time="2026-04-11T07:59:10Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:10 volumio go-librespot[28800]: time="2026-04-11T07:59:10Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:10 volumio go-librespot[28800]: time="2026-04-11T07:59:10Z" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.1.133:4070: connect: connection refused" Apr 11 07:59:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:12 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:12 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:13 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299785. Apr 11 07:59:13 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:13 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:13 volumio go-librespot[28808]: Librespot-go daemon starting... Apr 11 07:59:13 volumio go-librespot[28808]: time="2026-04-11T07:59:13Z" level=info msg="generated new device id: 38a66f0a656993eb7231ef0667c8a478508daaf3" Apr 11 07:59:13 volumio go-librespot[28808]: time="2026-04-11T07:59:13Z" level=debug msg="obtained new client token: AABg9BGTH+o1aCr5w2y3uG4/MyB87hs3fXJkOEHzVqCvV6vXMRD/yXCE+yR3BeQ3gRn43kglOsYoL2An3AB0FdB6WrH9lIdC0M0RyuTIqe9zNsIQK3NEhBqrQclv2B9xLI33UncjI1cLcCub0u+Hd7T8kgLyzv2ih0vVQH2khisbsfDe50LSt6IGHBuYhU4ziSmcZl4heueP2+jfdxUci1ciVtxy6jgK58Dc+3XIhR2GmewyMzuQxM/p7w3kTrld" Apr 11 07:59:13 volumio go-librespot[28808]: time="2026-04-11T07:59:13Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:13 volumio go-librespot[28808]: time="2026-04-11T07:59:13Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:14 volumio go-librespot[28808]: time="2026-04-11T07:59:14Z" level=fatal msg="failed running with username and spotify token" error="failed initializing accesspoint: failed dialing accesspoint: dial tcp 34.158.1.133:4070: connect: connection refused" Apr 11 07:59:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:15 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:15 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:17 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299786. Apr 11 07:59:17 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:17 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:17 volumio go-librespot[28817]: Librespot-go daemon starting... Apr 11 07:59:17 volumio go-librespot[28817]: time="2026-04-11T07:59:17Z" level=info msg="generated new device id: ea4f2b5c655a030da52237f0131e9e00877327cb" Apr 11 07:59:17 volumio go-librespot[28817]: time="2026-04-11T07:59:17Z" level=debug msg="obtained new client token: AABiewktICehUWE229oSszhksTV7ApJdp1QtpaEgNVYgudGdnNjc0gXz6pPSyulmR2789FOt6s0MARZ3YhJ78wSHvEnI7k+jWY/AB4tLHYPd9wrs/Ds2qF18uBjmNyvwV5xOPGCbClAOeeurk7aeH7oAJO+sg1443UuYYIIc2nVQQochUVsZSrRa6LV/mx806yzcRCMKeTpz0JjmyPMYz88pesAw5Z230EgwTpGesBkHs0/NxVOI7chgUhX3NHih" Apr 11 07:59:17 volumio go-librespot[28817]: time="2026-04-11T07:59:17Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:17 volumio go-librespot[28817]: time="2026-04-11T07:59:17Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:17 volumio go-librespot[28817]: time="2026-04-11T07:59:17Z" level=debug msg="completed keyexchange" Apr 11 07:59:18 volumio go-librespot[28817]: time="2026-04-11T07:59:18Z" level=debug msg="completed challenge" Apr 11 07:59:18 volumio go-librespot[28817]: time="2026-04-11T07:59:18Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:18 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:18 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:18 volumio volumio[698]: BT PLUGIN MESSAGE: Duration is 21570003 Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:59:18 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:59:18 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:59:18 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:59:18 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::servicePushState Apr 11 07:59:18 volumio volumio[698]: info: CoreStateMachine::pushState Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 07:59:18 volumio volumio[698]: info: CoreCommandRouter::volumioPushState Apr 11 07:59:18 volumio volumio[698]: info: MRS: Pushing multiroomSync output update for this device Apr 11 07:59:18 volumio volumio[698]: info: MRS: Pushing multiroomSync output Apr 11 07:59:18 volumio volumio[698]: SPOTIFY: RECEIVED VOLUMIO VOLUME 93 Apr 11 07:59:21 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:21 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:21 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299787. Apr 11 07:59:21 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:21 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:21 volumio go-librespot[28826]: Librespot-go daemon starting... Apr 11 07:59:21 volumio go-librespot[28826]: time="2026-04-11T07:59:21Z" level=info msg="generated new device id: adcf52e048ef878c0cc9d74dcffaeae10b5ec9dd" Apr 11 07:59:21 volumio go-librespot[28826]: time="2026-04-11T07:59:21Z" level=debug msg="obtained new client token: AABqwypxmPc2AJwPORUe5XHnoPHZ2BgZ1YxpRubsvP0jpTBElqdTO8zmcDLTxLDI1O27is5bgh71hhbcZjeflLl2p/LA70Rt9W6F2we12fuIGPRqqwx4qk7lJASmOyr0I+OPKVz+9kV4QXeigfmrg1dC8HMQ0pR5XrEU7nmnme49ej9Cy5n6Is5xE4VQQIj7iAUz44rinZjasu+/EIox0dQf9p8tF/OEA1EzwI44G24OYY5UlejLq5ZFLW/kZ2F5" Apr 11 07:59:21 volumio go-librespot[28826]: time="2026-04-11T07:59:21Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:21 volumio go-librespot[28826]: time="2026-04-11T07:59:21Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:21 volumio go-librespot[28826]: time="2026-04-11T07:59:21Z" level=debug msg="completed keyexchange" Apr 11 07:59:22 volumio go-librespot[28826]: time="2026-04-11T07:59:22Z" level=debug msg="completed challenge" Apr 11 07:59:22 volumio go-librespot[28826]: time="2026-04-11T07:59:22Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:24 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:24 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:25 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299788. Apr 11 07:59:25 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:25 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:25 volumio go-librespot[28834]: Librespot-go daemon starting... Apr 11 07:59:25 volumio go-librespot[28834]: time="2026-04-11T07:59:25Z" level=info msg="generated new device id: 924e5794d194e030ac73b7575f5ced4abd19b506" Apr 11 07:59:25 volumio go-librespot[28834]: time="2026-04-11T07:59:25Z" level=debug msg="obtained new client token: AABd40r5c7757jWckR5ABfXSrLSl+zupoVarKcJ9ExRJGzAjo1nFvp4J0esMgaNBgrpQ/JlXqizfD2bFpQc01NywtM0obf+FgYOZov2ssQMrocLe8D7A+GA+5G4+coaBJEI4AG7qraljJWYpHs+tQ14nzxiyCWz+8ctz5I0Ug/uvWJjEOJVeO53MH692A2s0v1dSdpG0cNQboP7dZJMe/c0cFptC5L2xVZ4bRIm4ozwmvaEdYVVb2O2ve8KYjGos" Apr 11 07:59:25 volumio go-librespot[28834]: time="2026-04-11T07:59:25Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:25 volumio go-librespot[28834]: time="2026-04-11T07:59:25Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:25 volumio go-librespot[28834]: time="2026-04-11T07:59:25Z" level=debug msg="completed keyexchange" Apr 11 07:59:26 volumio go-librespot[28834]: time="2026-04-11T07:59:26Z" level=debug msg="completed challenge" Apr 11 07:59:26 volumio go-librespot[28834]: time="2026-04-11T07:59:26Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:27 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:27 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:28 volumio volumio[698]: info: CoreCommandRouter::volumioRandom Apr 11 07:59:28 volumio volumio[698]: info: CoreCommandRouter::writePlayerControls Apr 11 07:59:28 volumio volumio[698]: info: CoreStateMachine::setRepeat true single false Apr 11 07:59:28 volumio volumio[698]: info: WARNING: No repeat method for plugin bluetooth Apr 11 07:59:29 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:29 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299789. Apr 11 07:59:29 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:29 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:29 volumio go-librespot[28843]: Librespot-go daemon starting... Apr 11 07:59:29 volumio go-librespot[28843]: time="2026-04-11T07:59:29Z" level=info msg="generated new device id: dbd3909df601c7c29e70fa515b99f9b4718e8cd6" Apr 11 07:59:29 volumio go-librespot[28843]: time="2026-04-11T07:59:29Z" level=debug msg="obtained new client token: AAAXnjPnuO4bkoVYaaEtPY2hKErjXUp1cl2r67BaMLVlEX7quBg46QV8Nn3YMBXdD1RhedjBRcct4jNB3ZKuMycqVPfbpPEzZITd0Kf/Zrnu/VL0NVzBDqrHoiUEOOJZx2aN9oTnYH7Ez1lG32duySCqR0XrtAyCXpUBavEaygQJEEUWZSkUB2Z2ZiVhiEwElE+2LnG2wlJpmeO8wNBoG+lSewQVuQEJvO2ErWjjyKKjEDvN/m08A1aSIxm+cnH5" Apr 11 07:59:29 volumio go-librespot[28843]: time="2026-04-11T07:59:29Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:29 volumio volumio[698]: info: CoreCommandRouter::volumioRandom Apr 11 07:59:29 volumio volumio[698]: info: CoreCommandRouter::writePlayerControls Apr 11 07:59:29 volumio volumio[698]: info: CoreStateMachine::setRepeat true single false Apr 11 07:59:29 volumio volumio[698]: info: WARNING: No repeat method for plugin bluetooth Apr 11 07:59:29 volumio go-librespot[28843]: time="2026-04-11T07:59:29Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:29 volumio go-librespot[28843]: time="2026-04-11T07:59:29Z" level=debug msg="completed keyexchange" Apr 11 07:59:30 volumio go-librespot[28843]: time="2026-04-11T07:59:30Z" level=debug msg="completed challenge" Apr 11 07:59:30 volumio go-librespot[28843]: time="2026-04-11T07:59:30Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:30 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:30 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:33 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:33 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:33 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299790. Apr 11 07:59:33 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:33 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:33 volumio go-librespot[28852]: Librespot-go daemon starting... Apr 11 07:59:33 volumio go-librespot[28852]: time="2026-04-11T07:59:33Z" level=info msg="generated new device id: c7899bb7f7e4283ca37ec94fc6c5c0ca012956b0" Apr 11 07:59:33 volumio go-librespot[28852]: time="2026-04-11T07:59:33Z" level=debug msg="obtained new client token: AACpUiQRlzjVLV2lfPlHWPfwza5B39iXMjUtrCZLPYrFvvSCsGy3spgyFuInpNgTX4A+xlUZzosoiIgL2ACA9z29g5JS7Uzx7D+QCYxbXrMMKeOorH8/cd2K3DqrOB+qMsCvsg/thKnEDQf8umxu4xLTJzd3wCyh+B+UxbjAvmCJQd603YOTR0Z7+L0mUEp8OwapdOkIa9y/nKkJrOyvoj/M5XYXwZLCo+0+BDUQS8KP8iqXpliqUF4F2qgXB1t7" Apr 11 07:59:33 volumio go-librespot[28852]: time="2026-04-11T07:59:33Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:33 volumio go-librespot[28852]: time="2026-04-11T07:59:33Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:33 volumio go-librespot[28852]: time="2026-04-11T07:59:33Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Apr 11 07:59:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:36 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:36 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:36 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299791. Apr 11 07:59:36 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:36 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:36 volumio go-librespot[28860]: Librespot-go daemon starting... Apr 11 07:59:36 volumio go-librespot[28860]: time="2026-04-11T07:59:36Z" level=info msg="generated new device id: 9bc34e4c93fce9f9753d9f850a0cad175f90d721" Apr 11 07:59:36 volumio go-librespot[28860]: time="2026-04-11T07:59:36Z" level=debug msg="obtained new client token: AABQETQz4kmSI0LAZFGPwNWucPcRTqTbW5QrXGQiRJRDjyao8iBb6aSDerh48204P70UV1jCzdLGUN+o+rY/FsUSfVRWPYNYIr/Z0yoHW9qjnIXfJy9YlOeDuK7yk383vn1G7PWLFDjMc2bxICXBtcKniVuTT0i4NglnI6bMG5TBNbQF0MBu+cVmu60MhOy1Z9N+f20UROKgRFuJ9S+S4XhwN27UxSdfxXL/Of0BEFTMKmLbuu3s/ZjYtynx2451" Apr 11 07:59:36 volumio go-librespot[28860]: time="2026-04-11T07:59:36Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:36 volumio go-librespot[28860]: time="2026-04-11T07:59:36Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:37 volumio go-librespot[28860]: time="2026-04-11T07:59:37Z" level=debug msg="completed keyexchange" Apr 11 07:59:37 volumio go-librespot[28860]: time="2026-04-11T07:59:37Z" level=debug msg="completed challenge" Apr 11 07:59:37 volumio go-librespot[28860]: time="2026-04-11T07:59:37Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:37 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:37 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:39 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:39 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:40 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299792. Apr 11 07:59:40 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:40 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:40 volumio go-librespot[28869]: Librespot-go daemon starting... Apr 11 07:59:40 volumio go-librespot[28869]: time="2026-04-11T07:59:40Z" level=info msg="generated new device id: 1b7f866b5ee101f7ee324de531f4c989f85e57d3" Apr 11 07:59:40 volumio go-librespot[28869]: time="2026-04-11T07:59:40Z" level=debug msg="obtained new client token: AABk0UPmBnNy3q9f4GThwJ87TSo7eMohvzCJnCK7yRzJjyTO8be4SqzGxPvx72mqSXkB7shP8VbPWeBXgdnC54DsygNZ6oBs4ubDmbc/EHlcxZiB7evIB9n4tFimYZQeIR7U/myMom8oqkBSBDU11NKNCdqk7zF91myl6xvMx1tZbHYbnNpEVlRlT7C6tAinYclQOnXEJ5bTO+hvi9Vhst3mqd97whV8+wrun67aPYlXKSxMSJLyHWZX57M6O5nN" Apr 11 07:59:40 volumio go-librespot[28869]: time="2026-04-11T07:59:40Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:40 volumio go-librespot[28869]: time="2026-04-11T07:59:40Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 07:59:41 volumio go-librespot[28869]: time="2026-04-11T07:59:41Z" level=debug msg="completed keyexchange" Apr 11 07:59:41 volumio go-librespot[28869]: time="2026-04-11T07:59:41Z" level=debug msg="completed challenge" Apr 11 07:59:41 volumio go-librespot[28869]: time="2026-04-11T07:59:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:42 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:42 volumio volumio[698]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 11 07:59:44 volumio systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 11 07:59:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1299793. Apr 11 07:59:44 volumio systemd[1]: Stopped go-librespot Daemon. Apr 11 07:59:44 volumio systemd[1]: Started go-librespot Daemon. Apr 11 07:59:44 volumio go-librespot[28877]: Librespot-go daemon starting... Apr 11 07:59:44 volumio go-librespot[28877]: time="2026-04-11T07:59:44Z" level=info msg="generated new device id: b4809994c2796e39818285f68f751c6a387e6b51" Apr 11 07:59:44 volumio go-librespot[28877]: time="2026-04-11T07:59:44Z" level=debug msg="obtained new client token: AABNjhVV3/dGqX9h7P0H+NZoMKV9zeSFvPEMB5zfFc/GPb93zpak9J6/fgJWY6yxA5wb1LK91S/ShRbd88mm0yEnySXiwGOCefiSvxX+b7J0y9dAITrk2ecYwOUtDRevX0A+M9N6ypuvJz8byTsinS/AtLbJH2CAoFGchTg74uB1CMzu8Z2EA7MlLzIJnQYpnTTRcH6oI3vNb4sfAGGS4RXJqTVb5rPF1Zl6PnWgkn+bo5hXR+qi0+Az2aeO64ma" Apr 11 07:59:44 volumio go-librespot[28877]: time="2026-04-11T07:59:44Z" level=debug msg="stored credentials found for andreas.koller-co" Apr 11 07:59:44 volumio go-librespot[28877]: time="2026-04-11T07:59:44Z" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 11 07:59:45 volumio go-librespot[28877]: time="2026-04-11T07:59:45Z" level=debug msg="completed keyexchange" Apr 11 07:59:45 volumio volumio[698]: info: Initializing connection to go-librespot Websocket Apr 11 07:59:45 volumio go-librespot[28877]: time="2026-04-11T07:59:45Z" level=debug msg="new websocket client" Apr 11 07:59:45 volumio volumio[698]: info: Connection to go-librespot Websocket established Apr 11 07:59:45 volumio go-librespot[28877]: time="2026-04-11T07:59:45Z" level=debug msg="completed challenge" Apr 11 07:59:45 volumio go-librespot[28877]: time="2026-04-11T07:59:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: failed login: TravelRestriction" Apr 11 07:59:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 11 07:59:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 11 07:59:45 volumio volumio[698]: info: Connection to go-librespot Websocket closed Apr 11 07:59:46 volumio volumio[698]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Apr 11 07:59:46 volumio volumio[698]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Apr 11 07:59:46 volumio volumio[698]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 07:59:46 volumio volumio[698]: TypeError: Cannot read property 'then' of undefined Apr 11 07:59:46 volumio volumio[698]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:364:9) Apr 11 07:59:46 volumio volumio[698]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2224:30) Apr 11 07:59:46 volumio volumio[698]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1411:26) Apr 11 07:59:46 volumio volumio[698]: at Socket.emit (events.js:315:20) Apr 11 07:59:46 volumio volumio[698]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 11 07:59:46 volumio volumio[698]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 11 07:59:46 volumio volumio[698]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 07:59:47 volumio sudo[28895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 07:58 Apr 11 07:59:47 volumio sudo[28895]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"