Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::volumioGetBrowseSources
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 06 01:37:00 volumio volumio[24519]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Nov 06 01:37:00 volumio volumio[24519]: info: Completed starting MyVolumio Plugin
Nov 06 01:37:00 volumio volumio[24519]: [Metrics] CommandRouter: 32s 87.45ms
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::volumiosetStartupVolume
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::Close All Modals sent
Nov 06 01:37:00 volumio volumio[24519]: info: CoreCommandRouter::Close All Modals sent
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Nov 06 01:37:01 volumio volumio-remote-updater[874]: Test mode disabled
Nov 06 01:37:01 volumio volumio-remote-updater[874]: Alpha mode disabled
Nov 06 01:37:01 volumio volumio-remote-updater[874]: Alpha legacy test mode disabled
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Nov 06 01:37:01 volumio volumio[24519]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 06 01:37:01 volumio volumio[24519]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Nov 06 01:37:01 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:01 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 140.
Nov 06 01:37:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:02 volumio go-librespot[24947]: go-librespot daemon starting...
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="app state loaded"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=info msg="zeroconf server listening on port 41973"
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="obtained new client token: AADYLQPU64cPbXZ0jrxG6UHy8Cz45Cjr7uBSnC7N0Dl5CswjZSEkHfFV+VY4dsc3uSDV5Ec/QHzfaY518rjEiRsYJvLmGqShGRsbfYleN2QqJPFzi/lGR75+7s14KEQiA7R6F4TKg/Dw2V4K9UTOsdi9qnmRFfd03upQ9fj2Plf9U0Ohg3ThX4ROukaxExq5Di4zCNYBGJMCtzBd11QkFP/+KD0XMIZ66rxKG8Dj46214mBUT+tjieQ="
Nov 06 01:37:02 volumio go-librespot[24948]: time="2025-11-06T01:37:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:03 volumio go-librespot[24948]: time="2025-11-06T01:37:03Z" level=debug msg="completed keyexchange"
Nov 06 01:37:03 volumio go-librespot[24948]: time="2025-11-06T01:37:03Z" level=debug msg="completed challenge"
Nov 06 01:37:03 volumio go-librespot[24948]: time="2025-11-06T01:37:03Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:04 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:04 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 141.
Nov 06 01:37:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:06 volumio go-librespot[24956]: go-librespot daemon starting...
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=debug msg="app state loaded"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" 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 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" 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 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" 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 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=info msg="zeroconf server listening on port 43089"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=debug msg="obtained new client token: AACBD64n8YTY248HbNKVCpdXHMVqrOaD4BvLdv25MPK91l3LynGA4NGcdun4TxYBfy3tx6AGc/BMFtReWmsV/xrlpbEl6zAoiYLgii49mmLaw+g0I3XcHz36jwtbeSZmbDWAchOUfNC9mwGn0BHMrflqLiA2PM6Epr/NF4ZzYqy5TjagnZrjeYSTph+KObyz8s6HcpAnnXcjpVfBVrnnLfOeTRDCmDc+6otlNqhEFxiqTO/lHe+orUA="
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=debug msg="completed keyexchange"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=debug msg="completed challenge"
Nov 06 01:37:06 volumio go-librespot[24957]: time="2025-11-06T01:37:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:07 volumio volumio[24519]: info: BOOT COMPLETED
Nov 06 01:37:07 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:07 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:09 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:09 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:37:09 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:09 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 142.
Nov 06 01:37:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:09 volumio go-librespot[24978]: go-librespot daemon starting...
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="app state loaded"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=info msg="zeroconf server listening on port 46363"
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="obtained new client token: AACa7WU1ZDY0F96f3d+y6qKHg2QCfI1ClZ2DqxvA/+eyY5PMNakDavzArgrIcJ0Ys7e3/l/Ey/X0Z3Zha473+Tytg/uvTF8cpNBHpnvsDc4uwRxRZXHkzU+ilO6ikKYzO1Z2p9gJEmUlX+piiIYT1pVmotvwV3EmviVS6Cbum2VL1CqDmQZikkNxXIzdAW2iREbwrX32OPgXVh93fRfFZyurPPitdqzeZoKmtVm2mQOIMcK0H9fVr5g="
Nov 06 01:37:09 volumio go-librespot[24979]: time="2025-11-06T01:37:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:10 volumio go-librespot[24979]: time="2025-11-06T01:37:10Z" level=debug msg="completed keyexchange"
Nov 06 01:37:10 volumio go-librespot[24979]: time="2025-11-06T01:37:10Z" level=debug msg="completed challenge"
Nov 06 01:37:10 volumio go-librespot[24979]: time="2025-11-06T01:37:10Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:10 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:10 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 143.
Nov 06 01:37:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:13 volumio go-librespot[24987]: go-librespot daemon starting...
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=debug msg="app state loaded"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" 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 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" 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 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" 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 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=info msg="zeroconf server listening on port 36993"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=debug msg="obtained new client token: AADfabHndhefsRJQcWx8lFR5iJrbaXc4mJotYvHeDxZlbZ458M2tkjAGFB2MVjuRA6mzUV+hK9HKmUsVIIZ21BAfO7cYDFWA6m9lkcgkraL7VVlUQcpyMoTNLiRr0FlRbw/KKHHF0tIOy8VhYNo03gvj9giIRV0F++q4Hv9Ro0CvsjUac79YtkE22urHKfzqcIhlyYDLemPZusm7QsRFO3JGF+ujX8/eP2DDvrB0nW6YLcorh5cPCwc="
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=debug msg="completed keyexchange"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=debug msg="completed challenge"
Nov 06 01:37:13 volumio go-librespot[24988]: time="2025-11-06T01:37:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:13 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:13 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 144.
Nov 06 01:37:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:16 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:16 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:16 volumio go-librespot[24999]: go-librespot daemon starting...
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="app state loaded"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=info msg="zeroconf server listening on port 41611"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="obtained new client token: AABsDIaCbTgeImWUt0mYweJQpOjB8D8Z5N8yMJcQd2/oEYwocsVNeD9b5EQ36n/K3uFWrbi1MNJIp+8AaDxEuEAH3JMBwDiPzaDxl2o3g6tAEqDjUN+9PVOIqctW4qkiCi9xBIs82Xvw69lAMZB27bXT6LZC5LPRCnPEx1VzWXwLH4O6ZWREylbXrYfeaQq4BagxCazIMbp0h5J98SMWn11B2zQQYh1a4iqwKUPvwmW9DGcSfWBWMPs="
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="completed keyexchange"
Nov 06 01:37:16 volumio go-librespot[25000]: time="2025-11-06T01:37:16Z" level=debug msg="completed challenge"
Nov 06 01:37:17 volumio go-librespot[25000]: time="2025-11-06T01:37:17Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:19 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:19 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:37:19 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:19 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 145.
Nov 06 01:37:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:20 volumio go-librespot[25021]: go-librespot daemon starting...
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=debug msg="app state loaded"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" 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 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" 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 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" 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 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=info msg="zeroconf server listening on port 32933"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=debug msg="obtained new client token: AADVT78SmeKWOvrYqe9gruM0k0pQ4ANMrdHgg9BndtnimGt/nFXA8uXLgohY261+8jXh+Hv5SIFY+56CIYr9ANTihmPd5gpGZqoZ4goG14GZDpdjicppZ+c6IIrheQ4noN1IYBcSQWnZZe7QYLFi1kkbfGDsvscoQ1racUXbKIOffGSiqBqcj3wqFCchDj/WDUHhsN12UVEjOCBygRgSc7KHb/hwk7OxCZILwyqeZ//Yborti0GmA24="
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=debug msg="completed keyexchange"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=debug msg="completed challenge"
Nov 06 01:37:20 volumio go-librespot[25022]: time="2025-11-06T01:37:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:22 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:22 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 146.
Nov 06 01:37:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:23 volumio go-librespot[25029]: go-librespot daemon starting...
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=debug msg="app state loaded"
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" 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 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" 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 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=info msg="zeroconf server listening on port 39639"
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=debug msg="obtained new client token: AAAd96uy/zmIRaIB0sbNErr+9ghXkHmU/QLTreuszhsuUFTj+rDDPT4fLs8WJV9WpOEPJQ/0HFVwy6Bsmz+/j2RX38PikDhlsMr/iLqVWYDaii8OimrJJDPYKL/VYAEuEC1RrNzrfMGBUGHSpVezBjKc+/ftJ1gjmstDSdZD+rx8jmRMerqiEhkS1mNhBowDWPgsAfRrtRm24O9GtPs///Dn+/QoIwvCdhRMqP+O3ZNAbojIn0wQJGM="
Nov 06 01:37:23 volumio go-librespot[25030]: time="2025-11-06T01:37:23Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:24 volumio go-librespot[25030]: time="2025-11-06T01:37:24Z" level=debug msg="completed keyexchange"
Nov 06 01:37:24 volumio go-librespot[25030]: time="2025-11-06T01:37:24Z" level=debug msg="completed challenge"
Nov 06 01:37:24 volumio go-librespot[25030]: time="2025-11-06T01:37:24Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:24 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:24 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:25 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:25 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:25 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:37:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 147.
Nov 06 01:37:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:27 volumio go-librespot[25038]: go-librespot daemon starting...
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=debug msg="app state loaded"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" 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 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" 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 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" 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 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=info msg="zeroconf server listening on port 45245"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=debug msg="obtained new client token: AAAZDvH5beWYY7fndXUvsr3qNClnVExrmXmf6bEYYGmCTYarnXNn/KG41Zbs36uJQWYrllUfn4Pmof66sa4AQtvgrgzCNtcPSYqN7uyY4tiJM7B24YDFH3m65ZrLV+7idHrl7gweCAKiqxOOuBJ5kj89Xj9Il5aoaoD1V46xR1dB/ab4g/kBW9K8qWoJYhVmb/IqCnYCishwencP3QGhW4F4Rq1LHfc+VRoNn38EjLZ1WEDK9BVsAC0="
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=debug msg="completed keyexchange"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=debug msg="completed challenge"
Nov 06 01:37:27 volumio go-librespot[25039]: time="2025-11-06T01:37:27Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:28 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:28 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:29 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:29 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:37:29 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:29 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 148.
Nov 06 01:37:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:30 volumio go-librespot[25060]: go-librespot daemon starting...
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=debug msg="app state loaded"
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37: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 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37: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 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37: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 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=info msg="zeroconf server listening on port 32933"
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=debug msg="obtained new client token: AAB8jx7x0z4l/6F32CHifzgydQ8mkWhjY0kHEu/PxGV8seTBzkt5gkx1yXtB5vJUJW1h66Jt2zc5QL/gbyTutXMfiWG+I1PPyFjQcypSm8E9Ap+nmSMxkRvXxDkCSDt48tAkJNjonbkNq4GK6zAGjB9ZBtO4NLdYZ/OLSdCmQRNBoXjziSIyqynxDUfyoOeVbK1m1ftWuKoeyN/m/Op7duUwVcH5p5TjJriIKzdU/on7qxmVjveQAXk="
Nov 06 01:37:30 volumio go-librespot[25061]: time="2025-11-06T01:37:30Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:31 volumio go-librespot[25061]: time="2025-11-06T01:37:31Z" level=debug msg="completed keyexchange"
Nov 06 01:37:31 volumio go-librespot[25061]: time="2025-11-06T01:37:31Z" level=debug msg="completed challenge"
Nov 06 01:37:31 volumio go-librespot[25061]: time="2025-11-06T01:37:31Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:31 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:37:31 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:31 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:34 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 149.
Nov 06 01:37:34 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:34 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:34 volumio go-librespot[25068]: go-librespot daemon starting...
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=debug msg="app state loaded"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" 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 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" 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 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" 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 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=info msg="zeroconf server listening on port 33721"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=debug msg="obtained new client token: AACqzFVoNA5LHoG+1fe/5BDsew+cGyrlSV5WxJT8fa6a/Bmzw9PsE0cEIL2D108Z5Wvs7zsGsjWm5IZKjN8vttQ44N32uNDSrFzmDy/RHzbtLJb0ItO/0/GbVMtSaTt09YgffwmQKF2F5qjKN9nVvGRZILednRbIroRXU1EYuG9OYBLgW1sti0YcjBxAErBFB/wC2QHhxl4fJhmAj/tI/mbaIDFRkp5rFKFooMy1bswgAeWd/yv+7Sk="
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=debug msg="completed keyexchange"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=debug msg="completed challenge"
Nov 06 01:37:34 volumio go-librespot[25069]: time="2025-11-06T01:37:34Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:34 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:34 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:34 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:34 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:37 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:37:37 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 150.
Nov 06 01:37:37 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:37 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:37 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:37 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:37 volumio go-librespot[25079]: go-librespot daemon starting...
Nov 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" level=debug msg="app state loaded"
Nov 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" 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 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" 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 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" 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 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" level=info msg="zeroconf server listening on port 34061"
Nov 06 01:37:37 volumio go-librespot[25080]: time="2025-11-06T01:37:37Z" level=debug msg="obtained new client token: AACBFULxq+xkgKLRUeDfIWCp8fIq5rsw8OWCq5LBJZZksKDshoFCn62BWBz3Jwemq34LvxeLEmdDfAIIKWhsbrc1y04V+uWBlgFD5plTr44RT0UjAugAnrXxudjtlE5gfWUNZO/GXvOH7v9zfW/EbDBHLlokh3OnaW95spynqymDt4xpdHO9fUAspU8xuTl85dN8SyuByRB+lVIZMcG8KS3tSIJtfk3tAih3ciAqX/VNMLUMfBAokr0="
Nov 06 01:37:38 volumio go-librespot[25080]: time="2025-11-06T01:37:38Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:38 volumio go-librespot[25080]: time="2025-11-06T01:37:38Z" level=debug msg="completed keyexchange"
Nov 06 01:37:38 volumio go-librespot[25080]: time="2025-11-06T01:37:38Z" level=debug msg="completed challenge"
Nov 06 01:37:38 volumio go-librespot[25080]: time="2025-11-06T01:37:38Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:39 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:39 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:37:40 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:40 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 151.
Nov 06 01:37:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:41 volumio go-librespot[25101]: go-librespot daemon starting...
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=debug msg="app state loaded"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" 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 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" 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 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" 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 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=info msg="zeroconf server listening on port 33313"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=debug msg="obtained new client token: AABtdWcY/MxvVin1l2B/SEcP9f9Zf4raPSfkxCDkeq6uJKC006L53paP+Ak7HP1OCRbeAZCzXHZcPdMizMlaspB7JBG18r8qcVorVfdm9rx91vD0S4JZEvfB9CcmxMhAWEG+pL5Noy1L0m7aWqVXQcayhtvptNSOMOT6/fgMXdwjLDGeiGH6ee96l/Fz6UT+GcbLElEg2JJ9l8a5i5P+Q+H5D98uy3YXKYc26rY4/SD91C46dDzDEmo="
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=debug msg="completed keyexchange"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=debug msg="completed challenge"
Nov 06 01:37:41 volumio go-librespot[25102]: time="2025-11-06T01:37:41Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:43 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:43 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 152.
Nov 06 01:37:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:44 volumio go-librespot[25109]: go-librespot daemon starting...
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=debug msg="app state loaded"
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37: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-gue1.spotify.com:443 ap-gew4.spotify.com:80]"
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" 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 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" 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 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=info msg="zeroconf server listening on port 45903"
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=debug msg="obtained new client token: AABLZjd7zXvh9e55U7uz7LSMFh2d/UcfxhT8ZcWtF6NmDTF5xbsxXCTmWj37aERbJzQ5TcY6cejCQ1B4tnWEPvqFdJD46t7oI6D76yZZwbKme8B58oDnfyInRuUOocGJDfBUra6GaHSjP1Q60NbIcf/0DxTLsNGC6RYOihysVFtOfAGZPMMwfzSA7pS96+CAM/trcQzXU+YrTxufuFh7iYrRyP7BVx83FF3Jt/Vyq1O/lj1esKcoggY="
Nov 06 01:37:44 volumio go-librespot[25110]: time="2025-11-06T01:37:44Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:45 volumio go-librespot[25110]: time="2025-11-06T01:37:45Z" level=debug msg="completed keyexchange"
Nov 06 01:37:45 volumio go-librespot[25110]: time="2025-11-06T01:37:45Z" level=debug msg="completed challenge"
Nov 06 01:37:45 volumio go-librespot[25110]: time="2025-11-06T01:37:45Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:45 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:45 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:46 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:37:46 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:46 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 153.
Nov 06 01:37:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:48 volumio go-librespot[25118]: go-librespot daemon starting...
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=debug msg="app state loaded"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" 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 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" 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 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" 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 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=info msg="zeroconf server listening on port 39591"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=debug msg="obtained new client token: AACU6XCSozuAc+vaSTaBetv/JsuyD1jRUCy6GqO0ivioXwnIfNUELgc/lM3GTlGWVCMDcyuJxnvy2Du+80yasACaduk624bTZ68E8AB0FPyscEyGLJjhqC0ga5h/8PPy5jzBqB/sCPyzpCHzK1NpCb+VCF5A3t5FwIBZFKp9VwoI4R2zPpDk3YVtlXC4VYdU/1/QTB0UinlwpXtxXxvHlL+dJl6f1p2xVO4Q30eHt5BUSle537KWMr8="
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=debug msg="completed keyexchange"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=debug msg="completed challenge"
Nov 06 01:37:48 volumio go-librespot[25119]: time="2025-11-06T01:37:48Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:49 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:49 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:37:49 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:49 volumio volumio[24519]: info: Listing playlists
Nov 06 01:37:49 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:49 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 154.
Nov 06 01:37:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:51 volumio go-librespot[25142]: go-librespot daemon starting...
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=debug msg="app state loaded"
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" 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 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" 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 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" 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 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=info msg="zeroconf server listening on port 33093"
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=debug msg="obtained new client token: AACx9/9M6bk2ZbWg/KoeI5Lzje20I+Y9noVaWCyG6enrFdks1farrfy6lLVhUO9H6VlorwM9Ov+6uPuxsjr6ZFeVLctW8Xy7V25OchuxPj4GDjM9Y3dMJkNkVAUjMS1qrRJKqvtplX9Y5ljmtAjfv5dVThRgZwyl1Yv0SW8i3E4ALFV5nQqwvmRpk71EUaf9wMstspgcfVyF0mloaxMWPf4MuNAVbiw9C9/OWGWg6LHQQO8snktcHbI="
Nov 06 01:37:51 volumio go-librespot[25143]: time="2025-11-06T01:37:51Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:52 volumio go-librespot[25143]: time="2025-11-06T01:37:52Z" level=debug msg="completed keyexchange"
Nov 06 01:37:52 volumio go-librespot[25143]: time="2025-11-06T01:37:52Z" level=debug msg="completed challenge"
Nov 06 01:37:52 volumio go-librespot[25143]: time="2025-11-06T01:37:52Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:52 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:52 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 155.
Nov 06 01:37:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:55 volumio go-librespot[25153]: go-librespot daemon starting...
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=debug msg="app state loaded"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" 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 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" 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 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" 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 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=info msg="zeroconf server listening on port 33115"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=debug msg="obtained new client token: AABqPzunUdEHe0k6DFwx0+cZOmg5eU65KZKRuwvZNxGq2trOrRJAhu7RK2/Gva/JGilVYgFRyHVkDFbDASM9JIU02tm1c8s0RH4/fnsSCe3MdIwQjS+hbjZuR5YgEkeJMDcnyUfSVDIsgQ0dhFqRFPRnbnk2M0ed9J+1DliHzgU17oq8oueyPuj2srJ2AFHGLGYP/nP/basG5xz7gbwVIzFNjciuwCXazfct/OKmWKXDW5/IGr+NFbo="
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=debug msg="completed keyexchange"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=debug msg="completed challenge"
Nov 06 01:37:55 volumio go-librespot[25154]: time="2025-11-06T01:37:55Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:55 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:55 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:58 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:37:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 156.
Nov 06 01:37:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:58 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:37:58 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:37:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:37:58 volumio go-librespot[25161]: go-librespot daemon starting...
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="app state loaded"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=info msg="zeroconf server listening on port 40579"
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="obtained new client token: AADyhyOmYlaw68BAZgKdLs/iamAY5HQsCGNeAhRLVJWnSoMygYFvIF3BGBcXMucpuXxvrKm1AzKpZzWY/eb0A034OGI7YrAqgqbG28/qWDUgk6iTaNg0etcAOtBVYVTx73HGC/tL6/HO9RNtjRzxfXJwxTqWMAJjTN+948kJ3bJLdeaBPuESQJ2OoixHZGYoGLH4BQJRlY9U0RRTVAud/7axfUu2kQLtqFFLOCnQaE1sDjLj4FnEP4A="
Nov 06 01:37:58 volumio go-librespot[25162]: time="2025-11-06T01:37:58Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:37:59 volumio go-librespot[25162]: time="2025-11-06T01:37:59Z" level=debug msg="completed keyexchange"
Nov 06 01:37:59 volumio go-librespot[25162]: time="2025-11-06T01:37:59Z" level=debug msg="completed challenge"
Nov 06 01:37:59 volumio go-librespot[25162]: time="2025-11-06T01:37:59Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:37:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:37:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:37:59 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:37:59 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:38:01 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:01 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 157.
Nov 06 01:38:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:02 volumio go-librespot[25184]: go-librespot daemon starting...
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=debug msg="app state loaded"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" 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 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" 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 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" 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 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=info msg="zeroconf server listening on port 44687"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=debug msg="obtained new client token: AADFOZgU1fALz+MCkWkrMklMQoXLr8ZDbucKQ/T+Sv+Wb47jD8GTzTpRhORWPQt8s6kf+UeB+OHTseixRqTTLFcfptcPzJ4MWJXuOz8ZMeymP/EVB3vRo2bbcmivY75V7AYwqRskV6+Cmlo8fBM1+3pvKyfrfv7mhu0+GSp93do7/Wf9OCeBagD7+Y/UN1NrUaG2CwLvtnxrsyz1IOUTND+UWXXRPoP0k/w9V3DeQYy5zhF9CoDGEcA="
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=debug msg="completed keyexchange"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38:02Z" level=debug msg="completed challenge"
Nov 06 01:38:02 volumio go-librespot[25185]: time="2025-11-06T01:38: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 06 01:38:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:04 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:04 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 158.
Nov 06 01:38:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:05 volumio go-librespot[25192]: go-librespot daemon starting...
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=debug msg="app state loaded"
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38: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 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38: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 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38: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 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=info msg="zeroconf server listening on port 44277"
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=debug msg="obtained new client token: AAC1ExMTYu7EYDaiVyGyOmxVzPseQ1l10PijtRvEFyRQ/UFIHALRep0lU5IWulFMjJXjH/fMI+BnkcSlNp/HCLU7kiZtRnIlMbkmKeprwIQyycaEOKCWCrbbtpDoRac86+akKrzDJW7LxIyFCfld8DE5p2L0iLZ/7TDu5wVkkBLLcrP4WTpLe8VaRHIkXXbTcz3UJikizK4vDzznP/9ElrusrOrdBigHgV/Fn4O3EXIAtId/RrCCr5M="
Nov 06 01:38:05 volumio go-librespot[25193]: time="2025-11-06T01:38:05Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:06 volumio go-librespot[25193]: time="2025-11-06T01:38:06Z" level=debug msg="completed keyexchange"
Nov 06 01:38:06 volumio go-librespot[25193]: time="2025-11-06T01:38:06Z" level=debug msg="completed challenge"
Nov 06 01:38:06 volumio go-librespot[25193]: time="2025-11-06T01:38:06Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:38:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:07 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:07 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 159.
Nov 06 01:38:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:09 volumio go-librespot[25214]: go-librespot daemon starting...
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="app state loaded"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=info msg="zeroconf server listening on port 34771"
Nov 06 01:38:09 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="obtained new client token: AADU26ov5eE4isEHbzfPVMnyzC6ds1GVzMgU2STgpQ135cDj3NWW8LppfP3pNPW0rwueDpDtU7KsB/MNel2TBFf+Yu9OQbH7vRHM6RhKnDIjNwN+UPHsxh+W9vpXO+lItj1GdVFpICz4Z/2Q0Qu4BJFtjPjTo1at6JJ3MXcF8+u7ZSY5S9W/jF4RafqbGGoOwKHtVuhHSjps8Ht29J5Fnq1qga5msoXVMhVCWLCxaLkoJfFW1w5LG6w="
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="completed keyexchange"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38:09Z" level=debug msg="completed challenge"
Nov 06 01:38:09 volumio go-librespot[25215]: time="2025-11-06T01:38: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 06 01:38:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:09 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:38:09 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:38:09 volumio volumio[24519]: info: Listing playlists
Nov 06 01:38:09 volumio volumio[24519]: info: Listing playlists
Nov 06 01:38:10 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:10 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 160.
Nov 06 01:38:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:12 volumio go-librespot[25224]: go-librespot daemon starting...
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="app state loaded"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=info msg="zeroconf server listening on port 35547"
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="obtained new client token: AABlrlgqgDOnrvoz/KliseVQCqmpcjSrkFaGPAb8NkqgknlOFglRob32k0uJpRCVztbRkVvj8Bl1tVb4nsWyU7yCNkHpyvDl8ypaxWC0bpx36wAy9oq/AUvYI3emwwVXlBZ9lt8hFzQS/7CxCl6KKLFWfXTEewKyVYMwowVq/bCF7l2zE/4ESb+PKrJh+sFhXOjmAwAH+7YvaxkueRh3mjYGP0Zox5qT3E29qdiUXSl+9/IuBqE30I0="
Nov 06 01:38:12 volumio go-librespot[25225]: time="2025-11-06T01:38:12Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:13 volumio go-librespot[25225]: time="2025-11-06T01:38:13Z" level=debug msg="completed keyexchange"
Nov 06 01:38:13 volumio go-librespot[25225]: time="2025-11-06T01:38:13Z" level=debug msg="completed challenge"
Nov 06 01:38:13 volumio go-librespot[25225]: time="2025-11-06T01:38:13Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:38:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:13 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:13 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:16 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 161.
Nov 06 01:38:16 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:16 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:16 volumio go-librespot[25235]: go-librespot daemon starting...
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=debug msg="app state loaded"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38: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 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38: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 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38: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 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=info msg="zeroconf server listening on port 45591"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=debug msg="obtained new client token: AABG9x4Juxvs42uRqaCAhLKtq2I1HPRzrQJzQDlAmY8hyIKZezJmfNwi1o/ucqaUWDIcCPCn68/YNcSiYaG8O29RODoiPcbM9fnF7SypcfANewFxP5masoVN9/aYx/lWwetD75tVI5DLXoElLoOY/W8xd3PvThfcYmFar7587dmVDPuQ56mtlLJ2n4v4+xUfFmcrMRBFqL3iE9LvZJ1l81ncrjCH8Hcf9Fqd0xFuKoXXEeKdi3qhQdY="
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=debug msg="completed keyexchange"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38:16Z" level=debug msg="completed challenge"
Nov 06 01:38:16 volumio go-librespot[25236]: time="2025-11-06T01:38: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 06 01:38:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:16 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:16 volumio volumio[24519]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:19 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Nov 06 01:38:19 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Nov 06 01:38:19 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Nov 06 01:38:19 volumio volumio[24519]: info: CoreCommandRouter::volumioGetState
Nov 06 01:38:19 volumio volumio[24519]: info: CorePlayQueue::getTrack 0
Nov 06 01:38:19 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 162.
Nov 06 01:38:19 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:19 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Nov 06 01:38:19 volumio go-librespot[25282]: go-librespot daemon starting...
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=info msg="running go-librespot 0.4.0"
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=debug msg="app state loaded"
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=info msg="api server listening on 127.0.0.1:9879"
Nov 06 01:38:19 volumio volumio[24519]: info: Initializing connection to go-librespot Websocket
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=debug msg="new websocket client"
Nov 06 01:38:19 volumio volumio[24519]: info: Connection to go-librespot Websocket established
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38: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 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38: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 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38: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 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=info msg="zeroconf server listening on port 41971"
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=debug msg="obtained new client token: AAA+pTh/qesUnYnAhDCQlOixXflWkSq+PCuEjvX0ULSjazwOQWZVYyviJA0/hUA9fI+2i5sPIbFxwRj+GYd9c2yEhXgCRZZy3qM73bWlO+2CEAcyBxyR9/R85Dqalsxm1RGODe7OnWRGDuK+u/AhrkZ1QWTbNNdOSpGoHFVGHYA15gCHkQ6pDh949zcOSNISAa4K2NT3yagZ7OjgEuBZBTg8nW7SaPGXh97SyBOYrIzY/PUU/fl0Dek="
Nov 06 01:38:19 volumio go-librespot[25283]: time="2025-11-06T01:38:19Z" level=debug msg="connected to ap-gew1.spotify.com:4070"
Nov 06 01:38:20 volumio go-librespot[25283]: time="2025-11-06T01:38:20Z" level=debug msg="completed keyexchange"
Nov 06 01:38:20 volumio go-librespot[25283]: time="2025-11-06T01:38:20Z" level=debug msg="completed challenge"
Nov 06 01:38:20 volumio go-librespot[25283]: time="2025-11-06T01:38:20Z" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed authenticating: accesspoint login failed: TravelRestriction "
Nov 06 01:38:20 volumio volumio[24519]: info: Connection to go-librespot Websocket closed
Nov 06 01:38:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Nov 06 01:38:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Nov 06 01:38:21 volumio kernel: nfs: server 192.168.1.3 not responding, timed out
Nov 06 01:38:22 volumio volumio[24519]: info: Getting Spotify volume
Nov 06 01:38:22 volumio volumio[24519]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 06 01:38:22 volumio volumio[24519]: Error: connect ECONNREFUSED 127.0.0.1:9879
Nov 06 01:38:22 volumio volumio[24519]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Nov 06 01:38:22 volumio volumio[24519]: errno: -111,
Nov 06 01:38:22 volumio volumio[24519]: code: 'ECONNREFUSED',
Nov 06 01:38:22 volumio volumio[24519]: syscall: 'connect',
Nov 06 01:38:22 volumio volumio[24519]: address: '127.0.0.1',
Nov 06 01:38:22 volumio volumio[24519]: port: 9879,
Nov 06 01:38:22 volumio volumio[24519]: response: undefined
Nov 06 01:38:22 volumio volumio[24519]: }
Nov 06 01:38:22 volumio volumio[24519]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 06 01:38:22 volumio sudo[25304]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-06 01:37'
Nov 06 01:38:22 volumio sudo[25304]: 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"