Aug 27 17:14:00 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:00.104+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Aug 27 17:14:00 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:00.106+02:00 level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Aug 27 17:14:00 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:00.106+02:00 level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Aug 27 17:14:00 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 17:14:00 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 17:14:00 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 27 17:14:00 levi volumio[1270]: info: MYVOLUMIO: Adding device Aug 27 17:14:00 levi volumio[1270]: info: MYVOLUMIO: Evaluating Server Aug 27 17:14:00 levi volumio[1270]: info: Discovery: Disconnected from remote: 192.168.0.133 Aug 27 17:14:00 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 8. Aug 27 17:14:00 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:00 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:00 levi go-librespot[1903]: go-librespot daemon starting... Aug 27 17:14:00 levi go-librespot[1904]: time="2026-08-27T17:14:00+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:00 levi go-librespot[1904]: time="2026-08-27T17:14:00+02:00" level=debug msg="app state loaded" Aug 27 17:14:00 levi go-librespot[1904]: time="2026-08-27T17:14:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:01 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:01 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.107 Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=info msg="zeroconf server listening on port 43369" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:01 levi volumio[1270]: info: Discovery: A device disappeared from network Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="obtained new client token: AAFwPdUGVK7+fZDSo8s3hS/JTknVrCBcMYfJFSRzCstRLS6MxSfNHRY926Kr4T9dNt9hCU2/Vl/k6ptLc6tnVuD0QGOJVVFcF/k3N5bbmVTCODSVmXNMhI75+FzsSUT2rrk7bpePKGZJe6EH6yxTW+5kvQ/HZfB+4FyHyHDPHUUln5zsqcEKqER1g1aizAIH2A6Pb6PAPbpnMnJIDBEJgiJ8I3szxV2z1NdpW2g5fzlTqdgQm/7WK8kpXg==" Aug 27 17:14:01 levi volumio[1270]: info: Setting Geolocation for MyVolumio to eu10 Aug 27 17:14:01 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:01 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:01 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=debug msg="completed challenge" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:01 levi go-librespot[1904]: time="2026-08-27T17:14:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:01 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:01 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:01 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.133 Aug 27 17:14:02 levi volumio[1270]: info: Discovery: A device disappeared from network Aug 27 17:14:02 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: socket hang up Aug 27 17:14:02 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 17:14:02 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 27 17:14:02 levi volumio[1270]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Aug 27 17:14:02 levi volumio[1270]: info: Updating MyVolumio device info Aug 27 17:14:02 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:02 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:02 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 17:14:03 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 27 17:14:03 levi volumio[1270]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Aug 27 17:14:03 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:03.390+02:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=OQXryGwI1OUPmFpiGueePGSfT0u1 tokenExpiry=2026-08-27T18:14:03.390+02:00 Aug 27 17:14:03 levi volumio[1270]: info: Discovery: Disconnected from remote: 192.168.0.249 Aug 27 17:14:04 levi volumio[1270]: info: Received Get System Info Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 17:14:04 levi volumio[1270]: info: Discovery: Getting this device information Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::volumioGetState Aug 27 17:14:04 levi volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 27 17:14:04 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 27 17:14:04 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:04.652+02:00 level=INFO msg="enabling local network discovery" Aug 27 17:14:04 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:04.685+02:00 level=INFO msg="enabling BLE discovery" Aug 27 17:14:04 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.249 Aug 27 17:14:04 levi volumio[1270]: info: Discovery: A device disappeared from network Aug 27 17:14:05 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 9. Aug 27 17:14:05 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:05 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:05 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:05 levi go-librespot[1928]: go-librespot daemon starting... Aug 27 17:14:05 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="app state loaded" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:05 levi volumio5-onboarding[1880]: time=2026-08-27T17:14:05.569+02:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=info msg="zeroconf server listening on port 41165" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="obtained new client token: AAH7MB0uFtbcIsw/OGchfzM64GkMAf4z0MbblLzolvYfPD5+L7F5uYrvStOkidRDg3Co65qiAeKf9O31+M6okdkEFVtplpuPa18lXWtwxCxMMsMU/RR40PV0Y34Xqdh6U6M0te/9h/jNBh24z3qtaUcJhC/74XxwfrgQLFkYvQFohsSXIS6T6FlO2onfuebvMhKV4rZrvexniZJVDg46zTOrNLym2EzkTBDwQ1KO+8KhDYM3scPLfuF6QA==" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:05 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.249 Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=debug msg="completed challenge" Aug 27 17:14:05 levi go-librespot[1929]: time="2026-08-27T17:14:05+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:06 levi go-librespot[1929]: time="2026-08-27T17:14:06+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:06 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:06 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:06 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.133 Aug 27 17:14:07 levi volumio[1270]: error: MyVolumio Plugin failed to authenticate in a timely fashion Aug 27 17:14:07 levi volumio[1270]: info: Completed starting MyVolumio Plugin Aug 27 17:14:07 levi volumio[1270]: [Metrics] CommandRouter: 78s 531.69ms Aug 27 17:14:07 levi volumio[1270]: info: CoreCommandRouter::volumiosetStartupVolume Aug 27 17:14:07 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 17:14:08 levi volumio[1270]: info: VolumeController:: Setting startup Volume 20 Aug 27 17:14:08 levi volumio[1270]: info: VolumeController::SetAlsaVolume20 Aug 27 17:14:08 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 17:14:08 levi volumio[1270]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:14:08 levi volumio[1270]: info: CoreCommandRouter::Close All Modals sent Aug 27 17:14:08 levi volumio[1270]: info: CoreStateMachine::pushState Aug 27 17:14:08 levi volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 27 17:14:08 levi volumio[1270]: info: CoreCommandRouter::volumioPushState Aug 27 17:14:08 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.107 Aug 27 17:14:08 levi volumio[1270]: info: Discovery: Remote connection timeout: 192.168.0.107 Aug 27 17:14:08 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:08 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:08 levi volumio[1270]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Aug 27 17:14:08 levi volumio[1270]: info: FusionDsp - ---- read samplerate from file: 44100 Aug 27 17:14:08 levi volumio[1270]: info: camilladsp stopping service pid 1608... Aug 27 17:14:09 levi volumio[1270]: grep: /proc/1608/cmdline: binary file matches Aug 27 17:14:09 levi volumio[1270]: grep: /proc/1608/cmdline: binary file matches Aug 27 17:14:09 levi volumio[1270]: info: camilladsp service terminated, instance 1 Aug 27 17:14:09 levi volumio[1270]: info: FusionDsp - If filter freq >samplerate/2 then disable it Aug 27 17:14:09 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Aug 27 17:14:09 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:09 levi volumio[1270]: info: camilladsp service started and running in background, instance 1 Aug 27 17:14:09 levi volumio[1270]: info: camilladsp respawn in 100 ms (attempt 1/10) Aug 27 17:14:09 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 27 17:14:09 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 27 17:14:09 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 27 17:14:09 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:09 levi go-librespot[1968]: go-librespot daemon starting... Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=debug msg="app state loaded" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=info msg="zeroconf server listening on port 46567" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:09 levi go-librespot[1969]: time="2026-08-27T17:14:09+02:00" level=debug msg="obtained new client token: AAE1U2KLrTJTIW6m1/+mFAdm3mAYjv3mzqJ0bD3t4ek1/AzYygy9WzSuCGhSic3kqCMmc2pOaqAh/tftMMvuLTwOutRR4s+HNosRn2v4au2Oq2zjeTtA3l2YdUGqWUAkQ2B23A3q1m9s0ClIlkNI+G4zd/Rcwqnj3SHZBEtpL5+Wl24X8V9M2B0uxoKeCnSJ+CPX1hZUwW6CPSaxki2OagWV9DwLw/c4poCgHFV2jwc5XeXInR7lPbsTdQ==" Aug 27 17:14:10 levi go-librespot[1969]: time="2026-08-27T17:14:10+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:10 levi go-librespot[1969]: time="2026-08-27T17:14:10+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:10 levi go-librespot[1969]: time="2026-08-27T17:14:10+02:00" level=debug msg="completed challenge" Aug 27 17:14:10 levi go-librespot[1969]: time="2026-08-27T17:14:10+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:10 levi go-librespot[1969]: time="2026-08-27T17:14:10+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:10 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:10 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:10 levi volumio[1270]: info: Discovery: adding 1e410b6a-b209-4903-aeec-cb9ea4ce1944 Aug 27 17:14:10 levi volumio[1270]: info: Discovery: Found device Sleeping Room Aug 27 17:14:11 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.107 Aug 27 17:14:11 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:11 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:13 levi volumio[1270]: info: Discovery: adding c30feaf1-7b14-4f5d-9ff1-ea205aee41dc Aug 27 17:14:13 levi volumio[1270]: info: Discovery: Found device Flur Aug 27 17:14:13 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.133 Aug 27 17:14:13 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Aug 27 17:14:13 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:13 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:13 levi go-librespot[1989]: go-librespot daemon starting... Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=debug msg="app state loaded" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=info msg="zeroconf server listening on port 41613" Aug 27 17:14:13 levi go-librespot[1990]: time="2026-08-27T17:14:13+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=debug msg="obtained new client token: AAHffrU9hnS2MrMJBdXfnzFQv5E6XzUULakXjkSJEYeQ+RQ7taMa+1vWMvZvJ2R7ws7PT2lirGneAlIQfAB0dcCiz7PwmcrXTBZ2Yztv+obcC03ZKZzwLmjmZCAGSQ6PdmghLGYHsYzjF2/4rW6iqbeEqFfSQihChJ5E6gJwW320YN6/vRCZ4fmGZa8S247umJwauqxagIoxYz13LfPJHhmdMEOHeTTGGZJsjbokMdgTmq+TXQDD4/h1bA==" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=debug msg="completed challenge" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:14 levi go-librespot[1990]: time="2026-08-27T17:14:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:14 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:14 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:14 levi volumio[1270]: info: camilladsp respawn in 200 ms (attempt 2/10) Aug 27 17:14:14 levi upmpdcli[1999]: writing RSA key Aug 27 17:14:14 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:14 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:14 levi volumio[1270]: info: Discovery: Disconnected from remote: 192.168.0.187 Aug 27 17:14:14 levi volumio[1270]: info: Discovery: Disconnected from remote: 192.168.0.187 Aug 27 17:14:15 levi volumio[1270]: info: BOOT COMPLETED Aug 27 17:14:15 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.187 Aug 27 17:14:15 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.187 Aug 27 17:14:15 levi volumio[1270]: info: Discovery: A device disappeared from network Aug 27 17:14:15 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.249 Aug 27 17:14:15 levi volumio[1270]: info: Discovery: Remote connection timeout: 192.168.0.249 Aug 27 17:14:16 levi volumio[1270]: info: Discovery: adding 20cfab56-fb4c-41d1-80ce-67cbce3dce5a Aug 27 17:14:16 levi volumio[1270]: info: Discovery: Found device Kitchen Aug 27 17:14:16 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.249 Aug 27 17:14:17 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Aug 27 17:14:17 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:17 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:17 levi go-librespot[2022]: go-librespot daemon starting... Aug 27 17:14:17 levi go-librespot[2023]: time="2026-08-27T17:14:17+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:17 levi go-librespot[2023]: time="2026-08-27T17:14:17+02:00" level=debug msg="app state loaded" Aug 27 17:14:17 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:17 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:17 levi go-librespot[2023]: time="2026-08-27T17:14:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=info msg="zeroconf server listening on port 38841" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="obtained new client token: AAHR1pbDCDlNaS5OJokeIok0wdpTDygFTtK8L+xhGW8Quseqzu20NNO8e4S8g4nELbOTDWWk4v/qKhCIPPEmOkoZQMOcso0DRwcE3xjN3mJSjy7u86OoCdN0kLJeXy1DJgClXngJ6pHZrWS13LqPT0pxii22YA4pPIjr3dVWcL4GqeEgeDS/dZV0xuBPytFe+PC8dzAS9NXxYAVmt8jeSWP/w3DAwQrwU0e6PHEQcJfDnzaPeQe0vco=" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=debug msg="completed challenge" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:18 levi go-librespot[2023]: time="2026-08-27T17:14:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:18 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:18 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:20 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:20 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:21 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Aug 27 17:14:21 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:21 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:21 levi go-librespot[2032]: go-librespot daemon starting... Aug 27 17:14:21 levi go-librespot[2033]: time="2026-08-27T17:14:21+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:21 levi go-librespot[2033]: time="2026-08-27T17:14:21+02:00" level=debug msg="app state loaded" Aug 27 17:14:21 levi go-librespot[2033]: time="2026-08-27T17:14:21+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=info msg="zeroconf server listening on port 40671" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="obtained new client token: AAESbM7qv4zJ1PN2yngk/MYGXm2OrgMzBVc3ZXA7j3bPVKEKWVeQ1urFKnCAOPn2ijYK+sEycARa6ovBLvSiouZk7TY0TnU+XChehWTajPJ+ipotvF0MJoUhjRxeaYxT5jvBtHmIgrkOs8xGkgFgR/GnS0xm0PvZO08q1/hbuJ0wfO2Lcr0P8xCjkaY1lzknpyna3/THB8n7FYx4bQ+pNdXRuoqSOOYSz0FfTKnBADgG7EPQOvUxgf5/kw==" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=debug msg="completed challenge" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:22 levi go-librespot[2033]: time="2026-08-27T17:14:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:22 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:22 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:22 levi volumio[1270]: verbose: New Socket.io Connection to 192.168.0.28:3000 from 192.168.0.107 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Aug 27 17:14:23 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.187 Aug 27 17:14:23 levi volumio[1270]: info: Discovery: Remote connection error: 192.168.0.187 Aug 27 17:14:23 levi volumio[1270]: info: Discovery: Remote connection timeout: 192.168.0.187 Aug 27 17:14:23 levi volumio[1270]: info: Discovery: Remote connection timeout: 192.168.0.187 Aug 27 17:14:23 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:23 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:24 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 27 17:14:25 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Aug 27 17:14:25 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:25 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:25 levi go-librespot[2042]: go-librespot daemon starting... Aug 27 17:14:25 levi go-librespot[2043]: time="2026-08-27T17:14:25+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:25 levi go-librespot[2043]: time="2026-08-27T17:14:25+02:00" level=debug msg="app state loaded" Aug 27 17:14:25 levi go-librespot[2043]: time="2026-08-27T17:14:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=info msg="zeroconf server listening on port 43689" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="obtained new client token: AAFkKfcoOfqDpDdQDghnG/XgvUdDvJRqLxO4ATTlwwIE6Pnhp+WVuJNCgkUbdpBt4kw099LQgE3T3ElWYkdA3mye4eqUFfo4q8BQuE6mOY9LYFsqhKIrlvwhKHXq2WLKcaTTsMjKyDykGqP/l3gafp7hAJVxRNQnzzgZG0VR9ovXbNTiGIDqKFL0Y2u0IcjoxePps7WmIzjwlZ8A8StbRTk/vnBZjVVRHa+OeL530HfSdkPGWN3vCCYTaA==" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=debug msg="completed challenge" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:26 levi go-librespot[2043]: time="2026-08-27T17:14:26+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:26 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:26 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:26 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:26 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:27 levi volumio[1270]: info: Discovery: adding cddd9ed4-a62f-4c25-9092-f05b7d4951cd Aug 27 17:14:27 levi volumio[1270]: info: Discovery: Found device Bathroom Aug 27 17:14:27 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.187 Aug 27 17:14:28 levi volumio[1270]: verbose: New Socket.io Connection to 192.168.0.28:3000 from 192.168.0.133 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Aug 27 17:14:29 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Aug 27 17:14:29 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:29 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:29 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:29 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:29 levi go-librespot[2067]: go-librespot daemon starting... Aug 27 17:14:29 levi go-librespot[2069]: time="2026-08-27T17:14:29+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:29 levi go-librespot[2069]: time="2026-08-27T17:14:29+02:00" level=debug msg="app state loaded" Aug 27 17:14:29 levi go-librespot[2069]: time="2026-08-27T17:14:29+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=info msg="zeroconf server listening on port 33065" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="obtained new client token: AAG0g+PIcYgTfj8jt4BHqFhbUg0b7d7ACJRSfDInYJPefS0YZZYO4LQ5POc8Z2VAgFDeTHUWdy4dMwLq3yCQ5QvgbTkpTJv+bq5mrazxMhrYV9txM2A3yYKPtqe/v9FtBHmPkGOy0tJJoCxulYDxF1rIgst7Hxqln44GihBggK4z+3ZMeZd0wCDb+dLHv0HEj6UnxhqmLwq5ySZJJ5y9xtiOsywyJARvc05qRts+96Nv5kS902Bne99ZVg==" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=debug msg="completed challenge" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:30 levi go-librespot[2069]: time="2026-08-27T17:14:30+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:30 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:30 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:32 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:32 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:32 levi volumio[1270]: verbose: New Socket.io Connection to 192.168.0.28:3000 from 192.168.0.249 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Aug 27 17:14:32 levi volumio[1270]: info: CoreCommandRouter::volumioGetState Aug 27 17:14:32 levi volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 27 17:14:33 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Aug 27 17:14:33 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:33 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:33 levi go-librespot[2078]: go-librespot daemon starting... Aug 27 17:14:33 levi go-librespot[2079]: time="2026-08-27T17:14:33+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:33 levi go-librespot[2079]: time="2026-08-27T17:14:33+02:00" level=debug msg="app state loaded" Aug 27 17:14:33 levi go-librespot[2079]: time="2026-08-27T17:14:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:34 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=info msg="zeroconf server listening on port 45271" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="obtained new client token: AAGI0eZic29hlcgN690SKg/rfS9rFD+swZRo1Nj0xElf1ou+9R010Q9W6Gky0oGLGwk+nflDOFOt1K3y7zN2BSkpulTqwmEc/SJpE1rbu6Bs03httzTJ17Qo4lOMtJtXHOurAcCdyjSPYlHk8Zi7yhzKA7qmeAH7+g1R7DX3rPTEheidCdWWavjJj4rcnAEP7BdJbmZ40GSFnmC5NsMtMfT3VgVpgSyEKlCwW2PqVdI9NzvSz68qqMrWXA==" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=debug msg="completed challenge" Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:34 levi volumio[1270]: info: CoreCommandRouter::volumioGetState Aug 27 17:14:34 levi volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 27 17:14:34 levi go-librespot[2079]: time="2026-08-27T17:14:34+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:34 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:34 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:35 levi volumio[1270]: info: Discovery: Connected to remote: 192.168.0.249 Aug 27 17:14:35 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:36 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:37 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Aug 27 17:14:37 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:37 levi go-librespot[2102]: go-librespot daemon starting... Aug 27 17:14:37 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="app state loaded" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:38 levi volumio[1270]: info: Discovery: Connected to remote: 192.168.0.133 Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=info msg="zeroconf server listening on port 38749" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="obtained new client token: AAEi32XAwh/+ROdAU3J5zuoTEB/cQjUyAmTK9mW+mBeYGGscBwleniwRgq5zdDQh+W9k6S9hKjwJjgCli9NxESGx9XdLH639O4zqSLC/tAYc3OrilBcO46AeOlurDGDJW2aNBhUByiKcsOKtWXPnvu79zxf2Te+V/KEg+m9GLeZqZMfkLI5V05Mbi9uhO7nVoHYQdsYoyQDYYzeW5M+hTffu+5guRMYl6srKUitY78DhXHCruA6IfwwwIg==" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=debug msg="completed challenge" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:38 levi go-librespot[2103]: time="2026-08-27T17:14:38+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:38 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:38 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:39 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:39 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:39 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 27 17:14:39 levi volumio[1270]: info: Discovery: Connecting to remote: 192.168.0.107 Aug 27 17:14:40 levi volumio[1270]: info: CoreCommandRouter::volumioGetState Aug 27 17:14:40 levi volumio[1270]: info: CorePlayQueue::getTrack 0 Aug 27 17:14:40 levi volumio[1270]: verbose: New Socket.io Connection to 192.168.0.28:3000 from 192.168.0.187 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Aug 27 17:14:42 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Aug 27 17:14:42 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:42 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:42 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:42 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:42 levi go-librespot[2113]: go-librespot daemon starting... Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="app state loaded" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=info msg="zeroconf server listening on port 33737" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="obtained new client token: AAGUFwwbA+37SruIMLdv3jscay9FibE6Xtogk7U5HER9g2YWcK9Ub4hBm6eIDZFvQ5gRKsOwCWu+/lI9yzgy95hymffaegnIuYvLhiLzeWYX0JChAea/ZKUXyXONVoqx3kpzFxl74ht0sTsomcWRHzAFysl7C2CmGOaJW1H6odDLt0bTfMxnvLjVDXL27JBT+aFo1xUd5TA54VhoZQut6lRcrUSfYZmVS7vk5ZoXbClMexMdlRyzn3DFIw==" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=debug msg="completed challenge" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:42 levi go-librespot[2114]: time="2026-08-27T17:14:42+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:42 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:42 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:45 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:45 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:46 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Aug 27 17:14:46 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:46 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:46 levi go-librespot[2122]: go-librespot daemon starting... Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="app state loaded" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=info msg="zeroconf server listening on port 41713" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="obtained new client token: AAFbU0wSf/6dRxPYBTZco85Wkb+PPKo3axI/tq9yKuIHQdVuJhUrFoNkZ6GYpv5drSq8JepZN1IjDG7Vi8CfYdxmq2+wEmXXZyLUG3n/VuMqDsYz962lP+uV2ZU+ESJ0SzZLgvHa5QmC4NJD885F368WAUL81YYxrsM4ZFgVgg+BM27VAa5+MA24UbRYaQTBTxfD4IZx1ftf4QuqHIxPwYev+TIvhNBylU9UxywmPwuJUkRCiY0P2rS7Jw==" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=debug msg="completed challenge" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:46 levi go-librespot[2123]: time="2026-08-27T17:14:46+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:46 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:46 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:48 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:48 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:50 levi volumio[1270]: info: Discovery: Connected to remote: 192.168.0.187 Aug 27 17:14:50 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Aug 27 17:14:50 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:50 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:50 levi go-librespot[2146]: go-librespot daemon starting... Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="app state loaded" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:50 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=info msg="zeroconf server listening on port 36555" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="obtained new client token: AAHMIWOv2HNo2ghohtFXMc3ecj8zdJQUfnfDiLmvs9pjV/Qdx+DsK6I2Bmu85giRh9+AJKqoi2R0ah9zCZPtwGQ5IKtS1qOaRYb/YedrJC+hESKNQG00jA2b4zERahE6zK41yc9MVbWHi7+CqQgviN6m/vAZmYhSL/NXA8U472yY0RqqkwIfFhxiwIFE0AnVhPHLpdE6V1JiIeGLl7UIMIo7kwPD0uRVbocVVPxtTQKYjPIq7KldpR1SiQ==" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=debug msg="completed challenge" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:50 levi go-librespot[2147]: time="2026-08-27T17:14:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:50 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:50 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:51 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:51 levi volumio[1270]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:51 levi volumio[1270]: info: Discovery: Disconnected from remote: 192.168.0.133 Aug 27 17:14:54 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Aug 27 17:14:54 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:54 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:54 levi go-librespot[2156]: go-librespot daemon starting... Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="app state loaded" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:54 levi volumio[1270]: info: Initializing connection to go-librespot Websocket Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="new websocket client" Aug 27 17:14:54 levi volumio[1270]: info: Connection to go-librespot Websocket established Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=info msg="zeroconf server listening on port 39065" Aug 27 17:14:54 levi volumio[1270]: verbose: New Socket.io Connection to 192.168.0.28:3000 from 192.168.0.187 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="obtained new client token: AAFcvBM0AoaguIk06Ne2Wp4CrXTbVzeQhVajDeajSzdIKJWEHqmXWcCsrgaMJhEKUEAyNuO4eWa4zA/TioWNw+3SzUZ5JyghO53KGAHkfG7jW2+OULIJw7THTZOSsfoeUneRxCHT3Xt94rxYed3aAcyxZdK6hEEnNb8jJY8ElASjZP5vNJlbRsnK3iZqL7hwMYs72eyKycPPaiCxsOyduwPImJs+ah54Mrajg0Ma4Fv5j/wu8VeeP2mJBQ==" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=debug msg="completed challenge" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:54 levi go-librespot[2157]: time="2026-08-27T17:14:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:54 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:54 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:14:54 levi volumio[1270]: info: Connection to go-librespot Websocket closed Aug 27 17:14:56 levi volumio[1270]: info: Discovery: Connected to remote: 192.168.0.107 Aug 27 17:14:57 levi volumio[1270]: info: Getting Spotify volume Aug 27 17:14:57 levi volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 27 17:14:57 levi volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:14:57 levi volumio[1270]: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 27 17:14:57 levi volumio[1270]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Aug 27 17:14:57 levi volumio[1270]: errno: -111, Aug 27 17:14:57 levi volumio[1270]: code: 'ECONNREFUSED', Aug 27 17:14:57 levi volumio[1270]: syscall: 'connect', Aug 27 17:14:57 levi volumio[1270]: address: '127.0.0.1', Aug 27 17:14:57 levi volumio[1270]: port: 9879, Aug 27 17:14:57 levi volumio[1270]: response: undefined Aug 27 17:14:57 levi volumio[1270]: } Aug 27 17:14:57 levi volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 17:14:58 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Aug 27 17:14:58 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:58 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:14:58 levi go-librespot[2177]: go-librespot daemon starting... Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="app state loaded" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=info msg="zeroconf server listening on port 35693" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="obtained new client token: AAGmkSrbCdJR+TmY1RsUMLcfWZ080zYXCYcQx86/TfkyJVI/tdWbbEiujNgS+SeQ8WtOq5i7XDdaPbhOKc6lbFUETo8hfemJzWy1ftN8hQA7r4uK8HOHFwaqXBlUa44BKkiz7KwQ4KcCDwPCgLg0PBKVrJ5uckw6TN0fwEs6JQCHV7pQL/ZMW/EM62UQv6q5Ba2i4gy3Mcro6v8eOoTBfwo3Z52ppxgSJM0vPIaa50KJxgACpBuYxnoPdg==" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="completed keyexchange" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=debug msg="completed challenge" Aug 27 17:14:58 levi go-librespot[2182]: time="2026-08-27T17:14:58+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:14:59 levi go-librespot[2182]: time="2026-08-27T17:14:59+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:14:59 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:14:59 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:15:02 levi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Aug 27 17:15:02 levi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:15:02 levi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Aug 27 17:15:02 levi go-librespot[2202]: go-librespot daemon starting... Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=info msg="running go-librespot 0.7.1" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="app state loaded" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=info msg="zeroconf server listening on port 46579" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="obtained new client token: AAGcb6FgCicDUU1s7LSH54Vjje6FyzRVP1PhXzArC7Lxy2uszUMfWgU2CpakjieCtGGm1iMlB42EEFT6fkFX5+joT18hkp0trcOEiPeYDQoxhtCfVLY5CODfCedpY6Gae4b0dq3fV3sQQuQ48mPSmA6lyejRcnFjY8NtwquD9ZHfRVFDfar9OVLOxi2AHhmlB0QxSFz9GBXzYQRyoill1SsZifBqLZVdPAchSXmbOGJMIrLcPwCE7RTLZA==" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="completed keyexchange" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=debug msg="completed challenge" Aug 27 17:15:02 levi go-librespot[2203]: time="2026-08-27T17:15:02+02:00" level=info msg="authenticated AP" username="ni**-o" Aug 27 17:15:03 levi go-librespot[2203]: time="2026-08-27T17:15:03+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 27 17:15:03 levi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 27 17:15:03 levi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 27 17:15:03 levi sudo[2215]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-27 17:14' Aug 27 17:15:03 levi sudo[2215]: 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"