Aug 25 03:02:06 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:06 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:06 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:06 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:09 volumio volumio[1413]: info: Received OAUTH Data Aug 25 03:02:09 volumio volumio[1413]: info: Executing Spotify Oauth Login Aug 25 03:02:09 volumio volumio[1413]: info: Saving Spotify Refresh Token Aug 25 03:02:09 volumio volumio[1413]: info: New Spotify access tokenBQBYHfWJnE... Aug 25 03:02:09 volumio volumio[1413]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 25 03:02:09 volumio volumio[1413]: SPOTIFY: User informations: {"account_id":"LJn2dknpW3","country":"US","display_name":"Patrick Bennett","email":"hazen59@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1234914273"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/1234914273","id":"1234914273","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee851473bf057322e33a83d38451","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b821473bf057322e33a83d38451","width":64}],"product":"premium","type":"user","uri":"spotify:user:1234914273"} Aug 25 03:02:09 volumio volumio[1413]: info: Creating Spotify config file Aug 25 03:02:09 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 03:02:09 volumio volumio[1413]: info: Spotify config file written Aug 25 03:02:09 volumio sudo[3335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 25 03:02:09 volumio sudo[3335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 03:02:09 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Aug 25 03:02:09 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Aug 25 03:02:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:09 volumio volumio[1413]: info: Connection to go-librespot Websocket closed Aug 25 03:02:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:09 volumio sudo[3335]: pam_unix(sudo:session): session closed for user root Aug 25 03:02:09 volumio go-librespot[3337]: go-librespot daemon starting... Aug 25 03:02:09 volumio sudo[3340]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 03:02:09 volumio sudo[3340]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 03:02:09 volumio sudo[3340]: pam_unix(sudo:session): session closed for user root Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="app state loaded" Aug 25 03:02:10 volumio sudo[3347]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:10 volumio sudo[3347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 25 03:02:10 volumio sudo[3347]: pam_unix(sudo:session): session closed for user root Aug 25 03:02:10 volumio volumio[1413]: info: New Spotify access tokenBQD7Agf60L... Aug 25 03:02:10 volumio volumio[1413]: info: Spotify credentials grant success - running version from March 24, 2019 Aug 25 03:02:10 volumio volumio[1413]: verbose: New Socket.io Connection to 192.168.10.144 from 192.168.10.104 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::volumioGetVisibleSources Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:10 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 25 03:02:10 volumio volumio[1413]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 25 03:02:10 volumio volumio[1413]: info: Received Get System Info Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 03:02:10 volumio volumio[1413]: info: Discovery: Getting this device information Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:10 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:10 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:10 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 03:02:10 volumio volumio[1413]: SPOTIFY: User informations: {"account_id":"LJn2dknpW3","country":"US","display_name":"Patrick Bennett","email":"hazen59@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/1234914273"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/1234914273","id":"1234914273","images":[{"height":300,"url":"https://i.scdn.co/image/ab6775700000ee851473bf057322e33a83d38451","width":300},{"height":64,"url":"https://i.scdn.co/image/ab67757000003b821473bf057322e33a83d38451","width":64}],"product":"premium","type":"user","uri":"spotify:user:1234914273"} Aug 25 03:02:10 volumio volumio[1413]: info: Spotify Successfully logged in Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 03:02:10 volumio volumio[1413]: info: [1787644930181] CoreMusicLibrary::Adding element Spotify Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 03:02:10 volumio volumio[1413]: Cannot find translation for source Loopback Aug 25 03:02:10 volumio volumio[1413]: Cannot find translation for source Spotify Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=info msg="zeroconf server listening on port 45883" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:10 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="obtained new client token: AAHxiS1zKP4h1vZHZxsbwMlwqxlbD7JFmXnIBekdRYgAFjsyQMOwuCdW8AfYShZ18cy5pk4IRT5RaYkGYO+8EzdZNGExUqFuHSt9+4Azj/is/4ctPgUQuDDles8cT8u8XGf7oeskaToGa0Cz+v1v5bnrKV7ueTh6OnFLIBt0dmA3GrtLFgkv41eqGTZN5WojN0X2UChFWrXtWZDtjhugixSaQfnmXLhfGTQwY4eFiMzwA8P89hVf7yaw" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=debug msg="completed challenge" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:10 volumio go-librespot[3339]: time="2026-08-25T03:02:10-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 03:02:11 volumio volumio[1413]: info: Received Get System Info Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 03:02:11 volumio volumio[1413]: info: Discovery: Getting this device information Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:11 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:11 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 03:02:12 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 25 03:02:12 volumio volumio[1413]: info: Received Get System Info Aug 25 03:02:12 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 03:02:12 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 03:02:12 volumio volumio[1413]: info: Discovery: Getting this device information Aug 25 03:02:12 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:12 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:12 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 03:02:12 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:12 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:12 volumio volumio[1413]: info: go-librespot daemon successfully initialized Aug 25 03:02:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Aug 25 03:02:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:13 volumio go-librespot[3367]: go-librespot daemon starting... Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=debug msg="app state loaded" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:13 volumio go-librespot[3368]: time="2026-08-25T03:02:13-05:00" level=info msg="zeroconf server listening on port 36165" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=debug msg="obtained new client token: AAFEc3a0krtYLLpAKDUnwOzcxRGqR2VZqm58OHltwUIApLJ3Whe6tb9N0kPD83toqSStDms3V/x9GiscTqVPVjpF1NKUoNdQgKiiHn22B0vUG2S7Y30DUvjad9ua8qYqQ53m6ppaHJsNZLkNIRPhbekkLtFLMJbkpOeQAgd5XvejdD+PR0COxrNctTblWMqO4JU15XZ6B/RU6wRfLjLuYFbU7b+5Yp1jvzgdRVwpYCA/n4jN1fMp1Q==" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=debug msg="completed challenge" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:14 volumio go-librespot[3368]: time="2026-08-25T03:02:14-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:15 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:15 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:15 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:15 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:16 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:16 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Aug 25 03:02:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:17 volumio go-librespot[3379]: go-librespot daemon starting... Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="app state loaded" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=info msg="zeroconf server listening on port 32837" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="obtained new client token: AAEcufDp84/FkprchWXYycsJNRl+ms2zweHPjPUCM/oXM0zkp2Cv0Tv5vk2bhJBFpeVVNMX1bJv/cSZ56PDwlaiFgpIB1Kui/4o+GSbriVQwtFvvum4gSqDIStNQiGQsqUWXlCGOxRMoEVxAtHCzKpVxvUBGwwd/LodWecUr/x+lFAwoZRGMjDnxURxYrImyxi1Zun70wOsISSOSc9+7m2DaE1w6pzjL43eMEl34sQQFAYiQuMLUQJAy" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=debug msg="completed challenge" Aug 25 03:02:17 volumio go-librespot[3380]: time="2026-08-25T03:02:17-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:18 volumio go-librespot[3380]: time="2026-08-25T03:02:18-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:18 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:18 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:20 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 25 03:02:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Aug 25 03:02:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:21 volumio go-librespot[3404]: go-librespot daemon starting... Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="app state loaded" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=info msg="zeroconf server listening on port 41055" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="obtained new client token: AAHkpW1Cr+AARCRdahWS+WP4Fe5DvGp4yV0guBFsqfv1LIcKG3eUBCJblWVAYqc6HIIsh5s70RmjRlszaZ9Jqd5S7hDFpoUl5NXlHDRPzCeVWxUybt+1q+o/BYzKnU7L7UAioI4/6jZNFwSAvitJVR6g5iofnFPmSILlDKW9eUZAT3+ZrzgfI6PV0f1RgGwnZb2PuDNvXgVfRqdgcBKLQN8LJZu9jzAOxTSLway65vSNQuNoXn2hIMUy" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=debug msg="completed challenge" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:21 volumio go-librespot[3405]: time="2026-08-25T03:02:21-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:21 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:21 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Aug 25 03:02:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:25 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:25 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:25 volumio go-librespot[3414]: go-librespot daemon starting... Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="app state loaded" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=info msg="zeroconf server listening on port 45671" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="obtained new client token: AAGRXDocqVhj48m0MCvlhARlmSYUM7zW3PT3Jelwtve231CZqBW/fbOLo9iam4Rt/+LeZP6buLGswgpWhtU9Wx7DRsS7xIvGoeD8biurwifOq3YdE1DeHOgGxcCFExMsNkYPqlEdHTEbP5mW2Nj/Fo/Otsw/wnwqIu8pOQvhVWfd05fX8XtwmF5otdSsOPkKG3QpAlDJSdqPXsEAFMvJyloGqQsFy1M/PDstmw6/NNRi3q+3hrAbXLOm" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=debug msg="completed challenge" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:25 volumio go-librespot[3415]: time="2026-08-25T03:02:25-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:26 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:26 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:26 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:26 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:28 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:28 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 25 03:02:28 volumio volumio[1413]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 25 03:02:28 volumio volumio[1413]: info: Received Get System Version Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 03:02:28 volumio volumio[1413]: info: Received Get System Info Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 25 03:02:28 volumio volumio[1413]: info: Discovery: Getting this device information Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:28 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:28 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 25 03:02:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5. Aug 25 03:02:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:28 volumio go-librespot[3425]: go-librespot daemon starting... Aug 25 03:02:28 volumio go-librespot[3426]: time="2026-08-25T03:02:28-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:28 volumio go-librespot[3426]: time="2026-08-25T03:02:28-05:00" level=debug msg="app state loaded" Aug 25 03:02:28 volumio go-librespot[3426]: time="2026-08-25T03:02:28-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=info msg="zeroconf server listening on port 42743" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="obtained new client token: AAHBw4xXF+c6sRSnu3lK1IrbzPARq38oFg0RnkRpKkNF9fYiMeCI39tmhx/5JZi+NBHdiYs8vENGy2WkkyfpLlsqYyY540cjjidq+iQP1JUvwAyjn+bac2Q6oknoIxdFGeCM8HGoe8IAA+avZlL/WWhtHX9U7x5BMU2YmFoygB17E9U8nLSvxIIyEq6mFu8WI1YIUyNHZhluSJFAVuHoCuo+pDBpyBaKBCtIwCT1WeyaZSiNf8gYsQ==" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.255.62:4070: connect: connection refused" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="connected to ap-gue1.spotify.com:443" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=debug msg="completed challenge" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:29 volumio go-librespot[3426]: time="2026-08-25T03:02:29-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:29 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Aug 25 03:02:30 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Aug 25 03:02:30 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Aug 25 03:02:31 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:31 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6. Aug 25 03:02:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:32 volumio go-librespot[3474]: go-librespot daemon starting... Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="app state loaded" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=info msg="zeroconf server listening on port 38197" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="obtained new client token: AAFxc7M6fSelP/yWmHXKFwsX6ygvwhRuBpBdsyLcUcXy6temXIOOvLqj8WNYJjVMUUNvKJK+Cjen4Rp2Qwg/ofTU0aM7nmNOcveaLneerzuMT3Al8A3Ci2tp04i4vHBlYMh72uiQ9gULVj/PwydKuplavZCMBdf0H3eDvsBF2JQdCYTr7dQwewPIXYJ0+Ai7W54JYq1Y0FqiO+GL2vHyOxz6X+tWK8NeL89OytxkF8yy/oCgXbNQ4XnS" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=debug msg="completed challenge" Aug 25 03:02:32 volumio go-librespot[3475]: time="2026-08-25T03:02:32-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:33 volumio go-librespot[3475]: time="2026-08-25T03:02:33-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:34 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:34 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7. Aug 25 03:02:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:36 volumio go-librespot[3483]: go-librespot daemon starting... Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="app state loaded" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=info msg="zeroconf server listening on port 45953" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:36 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:36 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="obtained new client token: AAGif08QcqaICMS56fp1pTPYGKJQUnpUbJbcqVuWdbzIgUVq0fJaCPHfA7Ldvz7D50W2FsNFd/dA3x5ArKpBQ4kXQmWnSUr5x4lX6mCgYeXZ5Yph6hcdUdLVMV1xmcbX2Jr+6E+wsyKQmADuyh+5aCrwreT8t/TDaHjsVH8LO1ReZo1RJ6rS6JVbSH12zBC7qxbfzkQ1uRv56H2utk3ODi/dQhN6cQ5vuALKW2vlLG2TBz8x7NDCoLgo" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=debug msg="completed challenge" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:36 volumio go-librespot[3484]: time="2026-08-25T03:02:36-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:37 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:37 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8. Aug 25 03:02:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:40 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:40 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:40 volumio go-librespot[3493]: go-librespot daemon starting... Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="app state loaded" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=info msg="zeroconf server listening on port 39153" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="obtained new client token: AAEDvUNzN+UDd7BrTkJd3l7qQhaKyk5i1Hf+YSPjLDRo7BhimrmZR4pN88K8FHwx3gvtWQX1mS0oDCtzrCQSZuAG3nn9qjYb9uOGDZODI/jbgMpVlK64NvmT6DelAzFz69VntBQASgegNTJhu96EZ5gaDQK6WvHrOE/X4gsFxQpBjL4n2XYSpTS0pXmj8pFWTWR2rr81JTmotEDtIAspiF7YB7mTBssZP2a2MfJZJSM/GnHq4iovHb4a" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=debug msg="completed challenge" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:40 volumio go-librespot[3494]: time="2026-08-25T03:02:40-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:43 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:43 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Aug 25 03:02:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:43 volumio go-librespot[3517]: go-librespot daemon starting... Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=debug msg="app state loaded" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=info msg="zeroconf server listening on port 44215" Aug 25 03:02:43 volumio go-librespot[3518]: time="2026-08-25T03:02:43-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=debug msg="obtained new client token: AAGY3CTXFbVH+uym3mlwq2B1WlzxYp0783Wj5Avh8KjWvitFwbkLvZBBIuTeGvUHKIlTEQtw95nFPfQY1D+QgNI4V/mazTrnRClYyFyBF1klTHrEPjb76iTERzbyeAX+6bhQ6xm6h8jpn7MgWxSoxgN1zu2XTkHy0wa046+DYmOpZgQwIoNQWOEUuY9vzps8U7kcejH7O+uhoQy/wrgPuqHBAW3nyHrLCikLgKQ0gTnqwfSiDDySrg==" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=debug msg="completed challenge" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:44 volumio go-librespot[3518]: time="2026-08-25T03:02:44-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:46 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:46 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:46 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:46 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:46 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:46 volumio volumio[1413]: info: Listing playlists Aug 25 03:02:47 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Aug 25 03:02:47 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:47 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:47 volumio go-librespot[3527]: go-librespot daemon starting... Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="app state loaded" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=info msg="zeroconf server listening on port 34361" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="obtained new client token: AAGusFWib9vh/gRUo/LG95VV8BYBXh4FAm87q71TEFwU12pvwdMzNd7ZguZuwfpYEYbXhR46HxOZ/4m0XwXh01AE0vM5EkD4vTXrbhX5cHV1BMJE7lI+y0/Xy9t4LDUfCk27tiV1pgH0IxG9WDazhVT0v9JhQAQaLCmHoraQSSUYHcT0CQdSzqGzXuaS6yOxDXvvkcTN3CWZSyHjQtPKO9COed/TZdLz8KRZCSE95iE6WnGvnfcdJYeW" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:47 volumio go-librespot[3528]: time="2026-08-25T03:02:47-05:00" level=debug msg="completed challenge" Aug 25 03:02:48 volumio go-librespot[3528]: time="2026-08-25T03:02:48-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:48 volumio go-librespot[3528]: time="2026-08-25T03:02:48-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:49 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:49 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:49 volumio tailscaled[790]: logtail: upload succeeded after 1 failures and 51s Aug 25 03:02:49 volumio tailscaled[790]: logtail: upload: log upload of 24574 bytes compressed failed 429: rate limited on bytes transferred per ID Aug 25 03:02:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Aug 25 03:02:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:51 volumio go-librespot[3552]: go-librespot daemon starting... Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="app state loaded" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=info msg="zeroconf server listening on port 33911" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="obtained new client token: AAF9NfGkjDVe7d95glCrWTqYhDfyq5D8huYdnzaxQAA50b4F9EAYrXJOG+jQLYOuM4ODHHf5K6FZtkoHppdPYqblexk9PT6319I6siZtk78j7rPlKQrnY/QlVDkV3sJkIgiFIFG+hN/be2G/XoVa+sgN4LyRn9V8XS79zx/6d57TufG2/IzGIyHeVGzNReC5IDWhpqOuL61QY/wN8JLIsBk4eOxK79bRoy2lFIJuPIdJZCk+6/exdkDT" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=debug msg="completed challenge" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:51 volumio go-librespot[3553]: time="2026-08-25T03:02:51-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:52 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:52 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Aug 25 03:02:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:55 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:55 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:55 volumio go-librespot[3562]: go-librespot daemon starting... Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="app state loaded" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=info msg="zeroconf server listening on port 38333" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="obtained new client token: AAGcCngXC7742a1TJuGvMM7i60oqw3Mjb40Bu9uWxEXtFABU5ph+linn8Qc7m6N8dSeRrzWmcUPZxQu+YIPCilULiDOLNIzPKR0nwiJ2I2UKgvqfe03WnfI0ZA2Qc9Yl9X7PeJuWBMnz4uJlpqJvj5hJkYIzDxGrLlPdGhLGghwqyiDQ84DB+OEZmO8ZhfPsy3I7LWI8YLKruOxuUC0OuDpEbQPA9E5sS+LKC45mjGnSQJraX9cuclFy" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=debug msg="completed challenge" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:55 volumio go-librespot[3563]: time="2026-08-25T03:02:55-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:55 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:55 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:02:56 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:02:56 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:02:58 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:02:58 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:02:58 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Aug 25 03:02:58 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:58 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:02:58 volumio go-librespot[3572]: go-librespot daemon starting... Aug 25 03:02:58 volumio go-librespot[3573]: time="2026-08-25T03:02:58-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:02:58 volumio go-librespot[3573]: time="2026-08-25T03:02:58-05:00" level=debug msg="app state loaded" Aug 25 03:02:58 volumio go-librespot[3573]: time="2026-08-25T03:02:58-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=info msg="zeroconf server listening on port 42563" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="obtained new client token: AAHR4d3zmGT2eSHoIy6uhZU4r2cmNfAWebfLg8ZSWR2l1ZLXXMF15pFoRWV/ieXygQrz0d14lSVGZ8giwuJ8FQznYohEVDv3f6s+2laEy2IqVkZd4BIBHtd73nSObPPDHuAW6LukuN1j57KmRZh0Xy1pSXxgFOmXkS3Rfgta5wvuV/JxaJUoUWitgSggP7roBAqKo70JVLFVwVc4bRQUNcs0vTqx63Mirp2HoJGLES4vkigyny8L9g==" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="completed keyexchange" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=debug msg="completed challenge" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:02:59 volumio go-librespot[3573]: time="2026-08-25T03:02:59-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:02:59 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:02:59 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:01 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:01 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:02 volumio volumio[1413]: info: CoreCommandRouter::volumioGetQueue Aug 25 03:03:02 volumio volumio[1413]: info: CoreStateMachine::getQueue Aug 25 03:03:02 volumio volumio[1413]: info: CorePlayQueue::getQueue Aug 25 03:03:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Aug 25 03:03:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:02 volumio go-librespot[3597]: go-librespot daemon starting... Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="app state loaded" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=info msg="zeroconf server listening on port 45897" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="obtained new client token: AAFsBrJgIHLu/+YeeEqH969T/XLt1i1XSPKQOoONaajLyiJA5sR843mn80TBddzxVcRHeMIuIUPfZ8ZRtYvxYROW0sAc5jPXMDvjsZgXF5hVRNMhVxCdlhQLqhDKWrQ+Db9l02bU2A7Z62L60mFm+N99xEiSUJGmdGmU/126NUrF07c0U7ulzLw5/tqvDfXr6WgPzXYvdZCQcUFF7i5uofEUY0QiLpWcdwQpG5lmCe1isDDKteToADh/" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=debug msg="completed challenge" Aug 25 03:03:02 volumio go-librespot[3598]: time="2026-08-25T03:03:02-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:03 volumio go-librespot[3598]: time="2026-08-25T03:03:03-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:03 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:03 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:04 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:04 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:04 volumio volumio[1413]: info: CoreCommandRouter::executeOnPlugin: spop , handleBrowseUri Aug 25 03:03:04 volumio volumio[1413]: info: In handleBrowseUri, curUri=spotify Aug 25 03:03:04 volumio volumio[1413]: info: Preload queue cleared Aug 25 03:03:04 volumio volumio[1413]: info: Preload queue cleared Aug 25 03:03:04 volumio volumio[1413]: info: Preload queue cleared Aug 25 03:03:04 volumio volumio[1413]: info: Preload queue cleared Aug 25 03:03:06 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Aug 25 03:03:06 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:06 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:06 volumio go-librespot[3609]: go-librespot daemon starting... Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="app state loaded" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=info msg="zeroconf server listening on port 45473" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:06 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:03:06 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:03:06 volumio volumio[1413]: info: Listing playlists Aug 25 03:03:06 volumio volumio[1413]: info: Listing playlists Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="obtained new client token: AAGdvyloZSgZzwy1LMX9NQ1BTmw3KuKzxKNnufqLPQwcn00hnkK2tnLUcXXmxlgT2l+L4VwCklSFTNUnCrjsb3cYFpCvbggEXxQGisAO31FsUi/RnLn3O/XHvjdips2EGYvoyJuFTiNUKuzC63lgExxYcLm1cwHC8N16VcdSuaiOw6PjLDECThoadHCgSlK4S5QsIraJ5ZXEZ9MDCtL3L0KKXhjDKya9PF2DY9srFcsweoiXF7ePwEM7" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=debug msg="completed challenge" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:06 volumio go-librespot[3610]: time="2026-08-25T03:03:06-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:06 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:06 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:07 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:07 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Aug 25 03:03:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:10 volumio go-librespot[3620]: go-librespot daemon starting... Aug 25 03:03:10 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:10 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="app state loaded" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=info msg="zeroconf server listening on port 35045" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="obtained new client token: AAFQAetl6YtxXv413enoROz8RoKtt3cuMZeKJ0pUvyJd9FxrS96N+EBFdysC0bYAVFKoP8W+24fZBIhSFDv/4eZzQX1QwBIqON/rsEf4OMp/Jb8cCECnDLiFlfClp0QQO7j9Ivy0xRILIRpEy5QiznSuUg449l/XXCbAXN26mh16+ITX87KWGHLIxUGzkhWXIz/1ceMcZ+Nn7mGFVnJaRaI5bHOpibXXJlZeT9f5t8MMB4A0NZRk1vm/" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=debug msg="completed challenge" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:10 volumio go-librespot[3621]: time="2026-08-25T03:03:10-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:13 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:13 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Aug 25 03:03:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:13 volumio go-librespot[3644]: go-librespot daemon starting... Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=debug msg="app state loaded" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=info msg="zeroconf server listening on port 33759" Aug 25 03:03:13 volumio go-librespot[3645]: time="2026-08-25T03:03:13-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=debug msg="obtained new client token: AAEIxywQcfEjvEkTL1XGDtCrHNIeV9+IvazJ4ZJOmsj/BGAv7sGrZpYMdOsH8n4f5axwtsxsDHKlkCIR8ysfod+TM2ihO0poLCG2SJx4PRYpRSlrZPkxCvOvkjlZf4YsM9a3OvTzgSiNjlPxgSc7T9zvGt7v+E4XiMtISsNS1ytNyD1VUhQvvfqfsU5QBjs9SpRvX7Mfjd9cB/FXsvxaPwlpa9f6pDP7WPhlkON6HWwjPLJ6be/vqA==" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=debug msg="completed challenge" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:14 volumio go-librespot[3645]: time="2026-08-25T03:03:14-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:16 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:16 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:16 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:03:16 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:03:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Aug 25 03:03:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:17 volumio go-librespot[3654]: go-librespot daemon starting... Aug 25 03:03:17 volumio tailscaled[790]: magicsock: endpoints changed: 136.34.114.22:48646 (stun), 136.34.114.22:41641 (stun4localport), 192.168.10.144:41641 (local) Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="app state loaded" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=info msg="zeroconf server listening on port 39533" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="obtained new client token: AAGbMuvVINNmMviy+DSVEpIYdE5KZ91xCqvT/GhP2x72G2Q3AY9m7GkUfjFC5s5mC1zb1F0vYAERCvns9Or7bEslmHTl+Ld5d12WRVyeVXEhq/wh2nNTfSShBK6XRRmBw3qPz6RfcqRIuLHeRLytVy/uWuuLmoUMJhjMirHWMvkLsoDWiVz8neUVgnFjuJruop3lV+YTwPnil5xgHZ3I9MOJsdDNyIYo1ii5jVQj8sY63KOuvwqd7U/N" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=debug msg="completed challenge" Aug 25 03:03:17 volumio go-librespot[3655]: time="2026-08-25T03:03:17-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:18 volumio go-librespot[3655]: time="2026-08-25T03:03:18-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:19 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:19 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:21 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Aug 25 03:03:21 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:21 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:21 volumio go-librespot[3681]: go-librespot daemon starting... Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="app state loaded" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=info msg="zeroconf server listening on port 45871" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="obtained new client token: AAHdmuMUq7SHSCAWgtG3Iy/XJrPow5Hds254HIrTJ4n/YGWdCzzM29Mkm45nMkqDB34fd8ERFtI+6MIr4wamubyKRc2ZSdxN9zQbr5aN5oKaJZLeC/rkD3CEppKnjJ36ZaHCzppKcHiAfauEYQaOGFpSGueE5tZ2DGjrOAi2PrvVxh/17kw68I3vOBDGGmawusE9quAFCmedOULEpSBvgh5EHToHCDztdF6PBs51CaQLAXgq/4vPOYZ+" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=warning msg="failed to connect to AP ap-gue1.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.255.62:4070: connect: connection refused" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="connected to ap-gue1.spotify.com:443" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=debug msg="completed challenge" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:21 volumio go-librespot[3682]: time="2026-08-25T03:03:21-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:21 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:21 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:22 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:22 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Aug 25 03:03:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:25 volumio go-librespot[3691]: go-librespot daemon starting... Aug 25 03:03:25 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:25 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="app state loaded" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=info msg="zeroconf server listening on port 44047" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="obtained new client token: AAHgJ7hjPfY8wrlzvMrRpM4XhTCW2YdPfAieijaMuxe3zsz783bz7+tjnkvenoBNVXufEc7uS7di7F+6YM4gXCr5yB35twd81LY0k13QSGYcd4bLccCP8vMbn7RsrAXKWMaGJBfJC11NpHH3NwHVEc0GUSK81+WQ7DTiIXcOYjk6L9fyY5kbOFTAyi9B8Wh/7MmY/4sWEVi+MVEiPwW9NUVEz6K53njQC+E7M4dGB7yhRwXFRXp28jFd" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=debug msg="completed challenge" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:25 volumio go-librespot[3692]: time="2026-08-25T03:03:25-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:26 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:03:26 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:03:26 volumio volumio[1413]: info: Listing playlists Aug 25 03:03:26 volumio volumio[1413]: info: Listing playlists Aug 25 03:03:28 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:28 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Aug 25 03:03:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:28 volumio go-librespot[3702]: go-librespot daemon starting... Aug 25 03:03:28 volumio go-librespot[3703]: time="2026-08-25T03:03:28-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:28 volumio go-librespot[3703]: time="2026-08-25T03:03:28-05:00" level=debug msg="app state loaded" Aug 25 03:03:28 volumio go-librespot[3703]: time="2026-08-25T03:03:28-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=info msg="zeroconf server listening on port 46049" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="obtained new client token: AAHYITLG4CMzD2QZFMH0ZWokTn4zzVDut43zjtevUOQJCLfMJkPk/HoN5R0zfj96afXAQwi6mPb55LNhA9Zz59/yAD4L8HWkbeiPy3IBb+CnjdHKFNTdz/iF9Yj9/f2uUXs4KokP58DHjdOIVBkavOA9BpA+OPcqIgZxQx+rg300LQYk/LJ653ZwvazlxahMv1bCSUNcqF4ysbb10VVFfvAFaGlih3fK+ovydiHuHuPh2UjfLv9gXQ==" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=debug msg="completed challenge" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:29 volumio go-librespot[3703]: time="2026-08-25T03:03:29-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:29 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:29 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:31 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:31 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:32 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Aug 25 03:03:32 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:32 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:32 volumio go-librespot[3726]: go-librespot daemon starting... Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="app state loaded" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=info msg="zeroconf server listening on port 43815" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="obtained new client token: AAGgdZbkbuqJj+Bglf6JfBx/97wQiQ9ZZQTejMyZu3m9QU8VXUeY3vYWT7H9EdpqxhzAmoucKDH4AgNxfTjPCUANE+BQ+9BeSpmT3UvZhmhYzhUjenP/FI445NR16M2d9tNlLBFIv7OMz7lm/PMHoRwgTZ2rm4sumC744mzy5AudAYVZaaUjsjjsSzTmLOy4+u88qvC334jzCwzmVCNJNRKXN3CCi37K9oa6RXhOHjsriZZBE+Tckcbp" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=debug msg="completed challenge" Aug 25 03:03:32 volumio go-librespot[3727]: time="2026-08-25T03:03:32-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:33 volumio go-librespot[3727]: time="2026-08-25T03:03:33-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:34 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:34 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Aug 25 03:03:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:36 volumio go-librespot[3735]: go-librespot daemon starting... Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="app state loaded" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:36 volumio volumio[1413]: info: CoreCommandRouter::volumioGetState Aug 25 03:03:36 volumio volumio[1413]: info: CorePlayQueue::getTrack 0 Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=info msg="zeroconf server listening on port 46149" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="obtained new client token: AAFGqBfrdR6bEml8rQP+vmFK5yKm3VBZTYmTAwsHtxxAM2F6RtKlET3Q5gyAIF7cTmCsxjR21jXWN7jjUZHKlbCk2kGeg2Fs78bWuBONp+NRWYz3/q4xCOLWaNwp1EnDZTcwkFh07fHVdgpu/S2U4yKdSGN+yjHP0YfUCtUXB8lDqsSIRGJ0bEXNSztNyxwvO+YbxzsMM74IMLkEtHh7cillA3b/NwaLC/22AHh9RbU2Z33c/xK7LnJl" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=debug msg="completed challenge" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:36 volumio go-librespot[3736]: time="2026-08-25T03:03:36-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:37 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:37 volumio volumio[1413]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Aug 25 03:03:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 25 03:03:40 volumio go-librespot[3745]: go-librespot daemon starting... Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=info msg="running go-librespot 0.7.1" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="app state loaded" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 03:03:40 volumio volumio[1413]: info: Initializing connection to go-librespot Websocket Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="new websocket client" Aug 25 03:03:40 volumio volumio[1413]: info: Connection to go-librespot Websocket established Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gae2.spotify.com:443 ap-gew1.spotify.com:80]" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=info msg="zeroconf server listening on port 42141" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="obtained new client token: AAHTBcuqCQ3MRVVk+rWDt/QU8ywl8yRQAbzgvBqpH84jbX6yiMu4m/QTHcsPSzLTrtgarQHvIEPv0VN6Z5T9IEw2eh3hLLcOYEMfUItOLTH6sfqwJtwcMaIhxxee3HqrSvhwcLqXqkTOxmvCStESmI9/iOwB0ijIpLdBQSEKjbO88bXKGy3JudYWYRTN9Cr048E/0a5rBfo+dDhvevnYCQ7igJNdwa+Vmtk0R17YvnmguC65xJaEUnDL" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="completed keyexchange" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=debug msg="completed challenge" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=info msg="authenticated AP" username="12******73" Aug 25 03:03:40 volumio go-librespot[3746]: time="2026-08-25T03:03:40-05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 25 03:03:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 25 03:03:40 volumio volumio[1413]: info: Connection to go-librespot Websocket closed Aug 25 03:03:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 25 03:03:43 volumio volumio[1413]: info: Getting Spotify volume Aug 25 03:03:43 volumio volumio[1413]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 03:03:43 volumio volumio[1413]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 25 03:03:43 volumio volumio[1413]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 25 03:03:43 volumio volumio[1413]: errno: -111, Aug 25 03:03:43 volumio volumio[1413]: code: 'ECONNREFUSED', Aug 25 03:03:43 volumio volumio[1413]: syscall: 'connect', Aug 25 03:03:43 volumio volumio[1413]: address: '127.0.0.1', Aug 25 03:03:43 volumio volumio[1413]: port: 9879, Aug 25 03:03:43 volumio volumio[1413]: response: undefined Aug 25 03:03:43 volumio volumio[1413]: } Aug 25 03:03:43 volumio volumio[1413]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 03:03:43 volumio sudo[3783]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 03:02' Aug 25 03:03:43 volumio sudo[3783]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"