-- Logs begin at Sun 2026-08-30 08:01:37 IST, end at Sun 2026-08-30 10:58:43 IST. -- Aug 30 10:57:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237645. Aug 30 10:57:00 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:00 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:00 minidsp-shd go-librespot[23460]: go-librespot daemon starting... Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="app state loaded" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=info msg="zeroconf server listening on port 43005" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="obtained new client token: AAFPawz7oTVg3mzNCHhQ6evLrk1FZoH1q+Zz5lbYJHfPxUQ6nWzmPy7kE3tiGAOsZ3LReq5xLnctF8E06PhVLiMC2JDiaRkEd2GmSzkOzzYBuBga9nrKVeqx5TC+yWkEPCLxwCfIttYOYWL+UYXFcCBbAUVLYRwHG95NsDe9UTkL4n1JIl0lFLw0ZWg1D0Au0GGZdWCCm+7AX/LNjBk4aAEHRco3vHO8wdE7Q8zVo0HpA9ZDKD28xJU=" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=debug msg="completed challenge" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:00 minidsp-shd go-librespot[23460]: time="2026-08-30T10:57:00+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:01 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:01 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237646. Aug 30 10:57:04 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:04 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:04 minidsp-shd go-librespot[23509]: go-librespot daemon starting... Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="app state loaded" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=info msg="zeroconf server listening on port 38963" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="obtained new client token: AAFRg0Y1PJARkW2vNsM11SLDB33pfkLQmlvjclmGzMxXq+EZCTka/QhaIjDC4P6YTgoOc4EBSrqzV4a04VvZL26tKNnvc5IMA04sOwI2oU2HwppoW2XKSQmKdRnamlKkof47018MramYFXZPUXfrkSvXlxP9U2yoA9qA9y3232Y7H+DFkJOhN/idPPlv2a6yg9Q37gkydzkt42Xx1udB6+GmVjGM2hbV0RQnhhvE7BCk+IOEcmQkP0A=" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=debug msg="completed challenge" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:04 minidsp-shd go-librespot[23509]: time="2026-08-30T10:57:04+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:04 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:04 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:07 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:07 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:07 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:07 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237647. Aug 30 10:57:07 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:07 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:07 minidsp-shd go-librespot[23532]: go-librespot daemon starting... Aug 30 10:57:07 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:07+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:07 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:07+01:00" level=debug msg="app state loaded" Aug 30 10:57:07 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:07+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=info msg="zeroconf server listening on port 40535" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="obtained new client token: AAHOepBXrQTgHTYIkCuVtxTrhqlfBBYV+LNInGjfbwYwfuEIUkRNLX/671nRVNPMFSuw4UEgEBcXdWOd5M8eDVytR9YNSozifnkU2fDpbwmE5LB52HzQMdLMUE7OzQQWdhF3ZGe3l6CmnwVdKTU5Oh7ljFxTx4WgOQez4+MI8e0edFkLtXvS+CTRrhqduxkdZYFBBPJ+EY8elw9dlJr3MAICqE4ZNj+KWxegoHk397xGTnW5UyXE" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=debug msg="completed challenge" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:08 minidsp-shd go-librespot[23532]: time="2026-08-30T10:57:08+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:57:09 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:57:09 minidsp-shd volumio[710]: verbose: New Socket.io Connection to 192.168.68.50:3000 from 192.168.68.60 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 10:57:09 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 10:57:10 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:10 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:11 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:11 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237648. Aug 30 10:57:11 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:11 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:11 minidsp-shd go-librespot[23540]: go-librespot daemon starting... Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="app state loaded" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=info msg="zeroconf server listening on port 44961" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="obtained new client token: AAFtTTQ2rYz08tp9uu/LN2XBQ6VvmP3+aDYjhuW/PNerX4mocYSh6c9HsYoNrv2+BYQNda+59VYIXqEPpx7v4PH4r385saVAUD/IxQLtx/Z0yb/8cRuCwghUVvmZJLREbGzgIIssy//EGD/gfTdD5vhUVvDisI+aBgEv+Thw8+6j24srTGD7TdmBFbjrSwhjUF/BpTqTdqZzSBExAZkn+duPR+nHYoRmudYE8nEt22oKUPJgeRC8c6w=" Aug 30 10:57:11 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:11+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:12 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:12+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:12 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:12+01:00" level=debug msg="completed challenge" Aug 30 10:57:12 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:12+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:12 minidsp-shd go-librespot[23540]: time="2026-08-30T10:57:12+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:13 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:13 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237649. Aug 30 10:57:15 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:15 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:15 minidsp-shd go-librespot[23548]: go-librespot daemon starting... Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="app state loaded" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=info msg="zeroconf server listening on port 34583" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="obtained new client token: AAF2SgEXH6b12qbTylBlbToCY28ej9j16uLqqpbonDkipx8LcHeAm77GXXHW/9REll/4E6+mRAhXCqiiM2xcUf/rPaEQMiFKHf8Lfmd06YjKTJe2MZbry9cWagi+S4MUXoHU2I35KqVtQa11xc9LRHUaU4GbmkH4zppxEjd2vPVEh5+kd7kKZUhOLCPgJmAxd2dE+FIqT+Bp0ZowGHfZOkDXGMi0BtJruSLMCQcU1F9VTATg8ZFxpIY=" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=debug msg="completed challenge" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:15 minidsp-shd go-librespot[23548]: time="2026-08-30T10:57:15+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:16 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:16 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237650. Aug 30 10:57:19 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:19 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:19 minidsp-shd go-librespot[23570]: go-librespot daemon starting... Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="app state loaded" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=info msg="zeroconf server listening on port 35007" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="obtained new client token: AAGbzIVQtJRc22GINvkcKdDJdqIITnhUKyuJGozUDGO2vc4cwpWZtMyMMparxeh9V3h2jReEsvE6ZCPqgsdG2M50sjpJBx+TFEuLx0DvVPEoHQBqB2favySpd+goeQoedMKUpvlugutimiFCgbEahyaX5sqCPHZM/0qUQdtThfK2BFSifghXxGcGidFqkyPU+RPMEbrU2NtV6K/5QrCt1ZH3IHQFzEYmKF6qDaR1LVC2+MtJlQUYAFA=" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=debug msg="completed challenge" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:19 minidsp-shd go-librespot[23570]: time="2026-08-30T10:57:19+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:19 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:19 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:22 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:22 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:22 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:22 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237651. Aug 30 10:57:22 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:22 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:22 minidsp-shd go-librespot[23578]: go-librespot daemon starting... Aug 30 10:57:22 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:22+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:22 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:22+01:00" level=debug msg="app state loaded" Aug 30 10:57:22 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:22+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=info msg="zeroconf server listening on port 35821" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="obtained new client token: AAGO4EysWB/33zgx5xZ8hZ/eQ3j5E9bhl+jZfy9rf9OaLrOZ7/vH1ME9uTXwz10gi0Y3ti/Xkek3/bEn0+Pee+yFv1aAlpmy1Ycrd33ZKKnMbmk0MqCrL8R48Yi1im/7qDLH8B2Sq0hMQknwSJLrfB+GNccIRqj5K1F6YSPNcZXHz53NP+piM16c3kL5t+hTYDsuxIxa18FcbQiFY3C4G3YsDa4VnDneSWZO55ReYGdBkr51Ji+G" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=debug msg="completed challenge" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:23 minidsp-shd go-librespot[23578]: time="2026-08-30T10:57:23+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:25 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:25 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:26 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:26 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237652. Aug 30 10:57:26 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:26 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:26 minidsp-shd go-librespot[23601]: go-librespot daemon starting... Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="app state loaded" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=info msg="zeroconf server listening on port 41405" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="obtained new client token: AAFm7DnfuGGXCjm72hLEEDzSlqlM0k4VCGVyEqoAirKUEUvdtFQ0vzkLsd2MRbPEHKsyxgpm1VL2u+OBgs+Lyhk7eaoCWafAGn6yjI9Whzzylhf0SrT8Peq0PRd82Cbu/nSOVGXIQfMmf9eW0QdqqP/LeNT+7JAA/DaCbQ35DibEzADATj4m7mwQjOVnLlwmhT1y44BRXI3PtLgnhH9cgW7RlpgM5vYR4HITp2YoYWaR6zlXdeepJrE=" Aug 30 10:57:26 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:26+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:27 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:27+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:27 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:27+01:00" level=debug msg="completed challenge" Aug 30 10:57:27 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:27+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:27 minidsp-shd go-librespot[23601]: time="2026-08-30T10:57:27+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:28 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:28 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237653. Aug 30 10:57:30 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:30 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:30 minidsp-shd go-librespot[23609]: go-librespot daemon starting... Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="app state loaded" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=info msg="zeroconf server listening on port 34261" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="obtained new client token: AAG1UWce0yCp21jvPpPcJ3Oq2Nbkexpz8y8E0O7NaVSgfx/36kLOmL+SwyrsuHACdrv0uHLIqRtx7YJVVZwfmB82CqptXG4JFAHM5Zanc4hdaydZIKfF2URuVPpf2TNEZx9KBuNWreu1WeMNvIDSlnypzilCWq2ZAPNIIN1lNtcHF386GaKZ6vGr6BkZ04xfbGW2h7XyZVKU51EzoJg9YmoAa0yyPcjIsD0v39CUFj2YV8TvW/ol6kQ=" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=debug msg="completed challenge" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:30 minidsp-shd go-librespot[23609]: time="2026-08-30T10:57:30+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:31 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:31 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:57:33 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:57:33 minidsp-shd volumio[710]: verbose: New Socket.io Connection to 192.168.68.50:3000 from 192.168.68.60 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 10:57:33 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 10:57:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237654. Aug 30 10:57:34 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:34 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:34 minidsp-shd go-librespot[23617]: go-librespot daemon starting... Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="app state loaded" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=info msg="zeroconf server listening on port 41661" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="obtained new client token: AAFVqeUBQ7kCM/RUWwqlWKvtZAkQg0jZ7AHBq261twotLR9oye2NNjQjerch5sjWnOEldFJyhakihi4GBzM9vlSNhvFPgsIujVeUQ38ZZibhOHFZohk3YdGvgwgPxbGPGpoJQoRfNBUZQg3pKzN9300Hh3FGFxF4cfBe/sgUz022Og1SBuXhW+0P/pHm2cFodzTL5XlL1bKdkrZyzJWnW/BuOVn+8nEXPxp2uLQlf+vHkQ1+Cn6cav4=" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.65.9:443: connect: connection refused" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="connected to ap-gew1.spotify.com:80" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=debug msg="completed challenge" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:34 minidsp-shd go-librespot[23617]: time="2026-08-30T10:57:34+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:34 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:34 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:37 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:37 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:37 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:37 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237655. Aug 30 10:57:37 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:37 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:37 minidsp-shd go-librespot[23639]: go-librespot daemon starting... Aug 30 10:57:37 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:37+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:37 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:37+01:00" level=debug msg="app state loaded" Aug 30 10:57:37 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:37+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=info msg="zeroconf server listening on port 42367" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="obtained new client token: AAGZKTTKhIl1gJ+M4SaKmHvzBWDSXiYUbK+2jTJGHYEV72nk/ltEaLUWip50PpfvZe3ceMZp8+ZIrQuO4P2EgvNRIXjbEDKfTCUdm2tJevCovRxCGUqU3pm3Co8xcE+G/FnB/WHPfY2pcW6JlCHQtUZJBFjR4HDHtOWIaej2W/R9jUDLonUjyVrlP1pvS/gh8yJYVzMLMiMtDNp2qD/wqFLJCHP8TEE3mKVhdimTnC6FMJmY97cP" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=debug msg="completed challenge" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:38 minidsp-shd go-librespot[23639]: time="2026-08-30T10:57:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:38 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:38 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:40 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:40 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:57:41 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:57:41 minidsp-shd volumio[710]: verbose: New Socket.io Connection to 192.168.68.50:3000 from 192.168.68.60 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 10:57:41 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 10:57:41 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:41 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237656. Aug 30 10:57:41 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:41 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:41 minidsp-shd go-librespot[23647]: go-librespot daemon starting... Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="app state loaded" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=info msg="zeroconf server listening on port 39163" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="obtained new client token: AAEXrLOd3m6yaUf+UZoNatDvAY9NX0ua9Bm/EL18ysFfjXrgQEv2tt2glsakFRM75L4jk50NtiqyqRacKtPuUAV8KVtq3r6ryr5GYcnrPd/QNMbK179pgQCL73dZx4mZhgYkghTJFYgnnl6/ULUB9tmTYcsR5PvOowkwf5NHYb1expfgn6vSFk3KjhW6vXgnbDK0OmvrqdFQ3rB4PnMl2OgwGboGgblAydI6k63CiTheGnC1GF3Il+M=" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:57:41 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:41+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Aug 30 10:57:42 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:42+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:42 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:42+01:00" level=debug msg="completed challenge" Aug 30 10:57:42 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:42+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:42 minidsp-shd go-librespot[23647]: time="2026-08-30T10:57:42+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:42 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:42 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:43 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:43 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:45 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:45 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237657. Aug 30 10:57:45 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:45 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:45 minidsp-shd go-librespot[23656]: go-librespot daemon starting... Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="app state loaded" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=info msg="zeroconf server listening on port 43971" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="obtained new client token: AAFhL0GftBPhdLKrh1cpRiAKfOmhq395JxfXbnTLCnL+gY19g3u2A0/I2b9ZcrqgPSzgqC2H+FQtHp7SpZmP1Ot1vsP0PRVl/ZipJIyV9pxJ84LLpYWpxggpNVRTo8mQVVtTuwwsgA9J4xDI/CS61xGHmMZQU/fcXDuSij6Yjb+idIWMkFPsJTxDM7Ldl4alUQMpmAwG5CY4sHYWVS80EemzIs9ZpfwLAK3hfXJdI+Iyd1Let1L1XhE=" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=debug msg="completed challenge" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:45 minidsp-shd go-librespot[23656]: time="2026-08-30T10:57:45+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:45 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:45 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:46 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:46 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:49 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:49 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237658. Aug 30 10:57:49 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:49 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:49 minidsp-shd go-librespot[23679]: go-librespot daemon starting... Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="app state loaded" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=info msg="zeroconf server listening on port 35031" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="obtained new client token: AAGLxXvJwSfpEdg51t1klbNKQROr4HevtBetzxgn1Tz+zWufPA8P+3oee19IFfbf+Srwn9zbgiyTfQRM25Wk6KFpvHaDw+PY6UALwKX30S8d2awxNaAAxh6pK2KN8pPieo2KDtYNetD7rqsIVVIgPG9kzzjKWYXTa43XfTQ5BUEvv69VuDlM1OtJPUpSGTHxKpTyh2Cl01D2KZLNP6OCVaG3v1j36ONcIVdHnE2dh6s8U08rNibYT1M=" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="completed challenge" Aug 30 10:57:49 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:49 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:49+01:00" level=debug msg="new websocket client" Aug 30 10:57:49 minidsp-shd volumio[710]: info: Connection to go-librespot Websocket established Aug 30 10:57:50 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:50+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:50 minidsp-shd go-librespot[23679]: time="2026-08-30T10:57:50+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:50 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:50 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:50 minidsp-shd volumio[710]: info: Connection to go-librespot Websocket closed Aug 30 10:57:52 minidsp-shd volumio[710]: info: Getting Spotify volume Aug 30 10:57:52 minidsp-shd volumio[710]: (node:710) UnhandledPromiseRejectionWarning: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:52 minidsp-shd volumio[710]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) Aug 30 10:57:52 minidsp-shd volumio[710]: (node:710) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 8252) Aug 30 10:57:52 minidsp-shd volumio[710]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 30 10:57:52 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:57:52 minidsp-shd volumio[710]: SPOTIFY: RECEIVED VOLUMIO VOLUME 78 Aug 30 10:57:52 minidsp-shd volumio[710]: SPOTIFY: SPOTIFY VOLUME 79 Aug 30 10:57:52 minidsp-shd volumio[710]: SPOTIFY: VOLUMIO VOLUME 78 Aug 30 10:57:52 minidsp-shd volumio[710]: SPOTIFY: DELTA VOLUME ENOUGH: false Aug 30 10:57:53 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:53 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:53 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:53 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237659. Aug 30 10:57:53 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:53 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:53 minidsp-shd go-librespot[23687]: go-librespot daemon starting... Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="app state loaded" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=info msg="zeroconf server listening on port 43249" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="obtained new client token: AAG38V2HncO3VpLUPA34/72FfNmgv4Q85bedgSMwcFb67xO7Kg6X9VISE/tJUmq4WQSw+wga8CINJcGijCHugkIH9csJfPwwAHwaWo/gjYpOfkeUeb3GFxCaDzO/LeOAhQoFEkL51I8LbDijK1V5NdgaU8DH2I6iG7mBUfPeslxqPWr+UCvUfRIftQw2kjhNJBOLMON9yneSI/mqEokan59nOxJX5x1fDeVYfNBH4GDLyxnfC+b8Dy0=" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=debug msg="completed challenge" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:53 minidsp-shd go-librespot[23687]: time="2026-08-30T10:57:53+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:53 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:53 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:56 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:56 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:57:57 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:57:57 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237660. Aug 30 10:57:57 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:57:57 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:57:57 minidsp-shd go-librespot[23709]: go-librespot daemon starting... Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="app state loaded" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=info msg="zeroconf server listening on port 35447" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="obtained new client token: AAGs76zVm/q1HgVaGAdlGseJenn8h3cmx9wjj3TTKm/qeTUXeAi99hqoGiCQ24sdOVToUDX5050Ru8VItMx1tTEbJ589qi3bDwiX/splbwPgiDT1W+mkwtrlemzb6OEHHASIULHmATVsJoSCrKwTmWCWLTMIBLUnjVrpNKUgTobAffIeyDlCnjAoKyD+1Epx5MC8fBt37JztVzP+JZO0Fg4G5Ly1IQPMXVbsUumNdPd/vFhErAzFx7k=" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="completed keyexchange" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=debug msg="completed challenge" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:57:57 minidsp-shd go-librespot[23709]: time="2026-08-30T10:57:57+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:57:57 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:57:57 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:57:59 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:57:59 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:00 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237661. Aug 30 10:58:00 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:00 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:00 minidsp-shd go-librespot[23718]: go-librespot daemon starting... Aug 30 10:58:00 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:00+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:00 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:00+01:00" level=debug msg="app state loaded" Aug 30 10:58:00 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=info msg="zeroconf server listening on port 43331" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="obtained new client token: AAHJsWqx+kIwDhzGgR58UgesfdVQTr/rmTY7KNkjDJm2M0WQkhk/LwSzA7qAqZYmAlXBbGdn/3iq71AOWwXS1DnsB1X+yatI5mSlu7NVkegMzBko1KVk1NYwEuZa3ETOQ2A/IBJgbs44DSU1FU5tHH4cfg7E4Hcl4YNrl3w8Zf60E2gBL3plJZKLdRnITI7BQ2XA5ioAbtCqGlEU1Q8+FCtIv6CS1neCOCj9H9d0/oRfhouxeOjc" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=debug msg="completed challenge" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:01 minidsp-shd go-librespot[23718]: time="2026-08-30T10:58:01+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:01 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:01 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:02 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:02 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:04 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237662. Aug 30 10:58:04 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:04 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:04 minidsp-shd go-librespot[23765]: go-librespot daemon starting... Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="app state loaded" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=info msg="zeroconf server listening on port 37835" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="obtained new client token: AAG87PUYx+/SnZDcXCf1hisO8e3++k6f3rUL53YgSLqIRwT4yvypmAyQVz6f+DA8UNy73pmtdYL5kWAP1FomxUvnKoupKtreq/06Tv5Yw1uAfi1tApHVbK6LVTvTQnIF8NgqGm/8TdTaZwVnLuX8IzEau5ARYfA7WuaOONT6PJ4ppeFyd4W9hNRF+L/s3j5++LMBrMi7noK6ny0JXtixKrRfog0lGFnn/xk/jl7GsgAYctErcTK3ibk=" Aug 30 10:58:04 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:04+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:05 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:05+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:05 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:05+01:00" level=debug msg="completed challenge" Aug 30 10:58:05 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:05+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:05 minidsp-shd go-librespot[23765]: time="2026-08-30T10:58:05+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:05 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:05 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:05 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:05 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:08 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:08 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237663. Aug 30 10:58:08 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:08 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:08 minidsp-shd go-librespot[23788]: go-librespot daemon starting... Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="app state loaded" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=info msg="zeroconf server listening on port 38381" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="obtained new client token: AAEI5E6xvbkd7MwwNrjQSFTv3i6nUZTBPrMxowT4uTYk+teecftP4tdi94EUVcHiUq6K2Vw5TRpEZyRXe4liH4xlNgkqRtH/QctYTx02ko1oFs2H7ce9G1wld21PN24IvYdfMVuhaDR0a+PLPDm+a7RpKBvqr878sy+f/zJ0gsb4OT8ncuN7bhAPXs+9wvcszJXh5N6g/RcEbsT5sv6moSj+J6cnVU9ADlgrRNxTJsTF5MyQJ8HHYOU=" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=debug msg="completed challenge" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:08 minidsp-shd go-librespot[23788]: time="2026-08-30T10:58:08+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:08 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:11 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:11 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237664. Aug 30 10:58:12 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:12 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:12 minidsp-shd go-librespot[23797]: go-librespot daemon starting... Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="app state loaded" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=info msg="zeroconf server listening on port 39079" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="obtained new client token: AAEbTMBwthGATxInM6IyeBzSZd0XLseGGWpTmA9FjPNPrZk4PDyM74avg+exCmPH0HLCxBWuvTzHGfI08WFlCO43rIdnPXRshm+q01bhb/DO1K/k0PuQtJplUFvq8JndH82A7nuGHa3doiX/A13bZuDfXy/xUMr6HjmXKDZWzUHKiMGEalry0Lda/eUdVvORd46nEe/JLk+A6g7HJEiP2GSaL4irARknvIPaNP3GYioDvdAYiPhLzqs=" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=debug msg="completed challenge" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:12 minidsp-shd go-librespot[23797]: time="2026-08-30T10:58:12+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:12 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:14 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:14 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:15 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237665. Aug 30 10:58:15 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:15 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:15 minidsp-shd go-librespot[23819]: go-librespot daemon starting... Aug 30 10:58:15 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:15+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:15 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:15+01:00" level=debug msg="app state loaded" Aug 30 10:58:15 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=info msg="zeroconf server listening on port 41953" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="obtained new client token: AAFaJKixghSXckPirIjEMF86pJpEkhYyUiiIiqwWZwBBhThVhwizYq0IKdtaPf7XUlgXMDjbFQAEcjQTpnLKn8K3xhLqvaLbYexlH4cLVrm9VD6Pf2UvUV2HUTEZE/ZpDrpCCDw8qX82oxlem2Z+I3Zb9121tbm8dCIwTeOa7kv3qpgHDVYaLe//M5iQMbeBW5cTK4EeyvF7Ba544V7w9jecXPWGVEpE4n7vBWtQ8uirgJRzdQIK" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=debug msg="completed challenge" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:16 minidsp-shd go-librespot[23819]: time="2026-08-30T10:58:16+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:16 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:16 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:17 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:17 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:19 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237666. Aug 30 10:58:19 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:19 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:19 minidsp-shd go-librespot[23827]: go-librespot daemon starting... Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="app state loaded" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=info msg="zeroconf server listening on port 43417" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="obtained new client token: AAEIfz62Ww64qEH3BSZ0dfscdXIobvsmK+nMcFDN0WbWlf23JEi4XfEwi/TU6+3q5ulLIkZTzWKruRUJZeKnJdVL6BuZg9H5DCz4om0US1cbIx1HGfOIXoWYx2tefw/1+kXzymo5NrhJXQz6DtfE/ENYbAAbwZUD4589qk7T+ihfU5bYXbq8R/7B4iqyOPPTZRd8P+JX+09l7+F20N6kUOrH1TDldok3sAazkiJhD4hDXBRg1XhXnOE=" Aug 30 10:58:19 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:19+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:20 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:20+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:20 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:20+01:00" level=debug msg="completed challenge" Aug 30 10:58:20 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:20+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:20 minidsp-shd go-librespot[23827]: time="2026-08-30T10:58:20+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:20 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:20 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:20 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:20 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:21 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 10:58:21 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 10:58:22 minidsp-shd sudo[23836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 10:58:22 minidsp-shd sudo[23836]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:58:22 minidsp-shd sudo[23836]: pam_unix(sudo:session): session closed for user root Aug 30 10:58:22 minidsp-shd sudo[23839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 10:58:22 minidsp-shd sudo[23839]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:58:22 minidsp-shd sudo[23839]: pam_unix(sudo:session): session closed for user root Aug 30 10:58:22 minidsp-shd volumio[710]: verbose: New Socket.io Connection to 192.168.68.50 from 192.168.68.60 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 10:58:22 minidsp-shd sudo[23844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 10:58:22 minidsp-shd sudo[23844]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:58:22 minidsp-shd sudo[23844]: pam_unix(sudo:session): session closed for user root Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 10:58:22 minidsp-shd sudo[23847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 10:58:22 minidsp-shd sudo[23847]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 10:58:22 minidsp-shd sudo[23847]: pam_unix(sudo:session): session closed for user root Aug 30 10:58:22 minidsp-shd volumio[710]: verbose: New Socket.io Connection to 192.168.68.50 from 192.168.68.60 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Aug 30 10:58:22 minidsp-shd volumio[710]: info: Received Get System Info Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:58:22 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:22 minidsp-shd volumio[710]: info: Listing playlists Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 10:58:22 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 10:58:23 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:23 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237667. Aug 30 10:58:23 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:23 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:23 minidsp-shd go-librespot[23851]: go-librespot daemon starting... Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="app state loaded" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=info msg="zeroconf server listening on port 38869" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="obtained new client token: AAFU1FAtCkDo3ihV7ZW1NhEfsJV38ola30UejhZ68vStZp8YY3wdemiDqmNkqkECavm+1DBDJdyD5QPETuTq0tZLZ7/zFKLt3+jAk18zH/PK7LdQ17OLDBA4t+Pn7Kvo6/RacTLraXKd/7l1Q0BueioDwjiQ9eXAYuaP0q9kGGJmK0f8gXY7bq1VZ2f2kkEmt+Dig1zp1WhMNZ7f/vAV07RQhvQWtO/bGKnYgrlAm27lKjUXWDquSVs=" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="connected to ap-gew1.spotify.com:443" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=debug msg="completed challenge" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:23 minidsp-shd go-librespot[23851]: time="2026-08-30T10:58:23+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 10:58:24 minidsp-shd volumio[710]: info: Received Get System Info Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:58:24 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:24 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:58:25 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 10:58:25 minidsp-shd volumio[710]: info: Received Get System Info Aug 30 10:58:25 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:58:25 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:58:25 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:58:25 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:25 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:58:26 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:26 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:26 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetQueue Aug 30 10:58:26 minidsp-shd volumio[710]: info: CoreStateMachine::getQueue Aug 30 10:58:26 minidsp-shd volumio[710]: info: CorePlayQueue::getQueue Aug 30 10:58:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237668. Aug 30 10:58:27 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:27 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:27 minidsp-shd go-librespot[23874]: go-librespot daemon starting... Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="app state loaded" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=info msg="zeroconf server listening on port 34823" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="obtained new client token: AAHVTG1u32xH/qyFfYj2EVXyJLD4fDlwYGaTABoSlfEdgg6D36UBxYbjZBUxauNKtaG+G0NGIVDIvH0Us6r2kQAHfmGfnlAZ87txhPXInUZXbp1bIuBlc58g9W406ubjVgfms/+xyBkv3drMnKUVDZbASnvC9w84HfnkNzTMk0kD++Q5dBAN3fXvIFjyhskXq/7/y+psr3xMFnTp5ijj0FczcljUirbVd8S+SPO4q5hSy/qAoCe1rnI=" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.65.9:443: connect: connection refused" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="connected to ap-gew1.spotify.com:80" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=debug msg="completed challenge" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:27 minidsp-shd go-librespot[23874]: time="2026-08-30T10:58:27+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:27 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:29 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:29 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:30 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237669. Aug 30 10:58:30 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:30 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:30 minidsp-shd go-librespot[23882]: go-librespot daemon starting... Aug 30 10:58:30 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:30+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:30 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:30+01:00" level=debug msg="app state loaded" Aug 30 10:58:30 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:30+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=info msg="zeroconf server listening on port 43709" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="obtained new client token: AAGnfbnFX+m70xqWW8nyjc2jBbT990d/qxU3vEpRFoMBFwfs6hQXJ6WTGuwGrRSFAU8cBu6f0hAux86zavjw4bqOQXiIe8e2I5bhLcqSc82YfyF+ig8RKr56UwoUc2awYZQhyjUKjS3TffylD3Bh7ju+TyXbScSw/Eh+YYcJIEcNRXGA3Jt+z7TkmEPC4WwMI6QC3fl4WIdT94wZuCfCRHkntOKaRslXtFmkHQDtb1F1eflzb9VB" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=debug msg="completed challenge" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:31 minidsp-shd go-librespot[23882]: time="2026-08-30T10:58:31+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:31 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:31 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:32 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:32 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:32 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 10:58:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:34 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237670. Aug 30 10:58:34 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:34 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:34 minidsp-shd go-librespot[23890]: go-librespot daemon starting... Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="app state loaded" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=info msg="zeroconf server listening on port 38751" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="obtained new client token: AAF+t1Wszy0PW78ixUSXQWzbac/eDtn6Fn8x8eCKvAXsRg8XGzPdFEXhPiabnzYH1r/vBesv4+QCvMEaokLcTKI71A075Ltbw/oO/7rpNAWh9tXqZV0dgyAzg/ri3tDXGK8KQ7pOj2kyWon9IGusPioFY5eWYP530y9GSXjvGxXlJIEh4iHhXxOYMMikRD8BcqBH6m4SUK3DM6tTAg4FZjpemmz7hXhNKDigX7JmndP+BIrKB+RVH18=" Aug 30 10:58:34 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:34+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:35 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:35+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:35 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:35+01:00" level=debug msg="completed challenge" Aug 30 10:58:35 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:35+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:35 minidsp-shd go-librespot[23890]: time="2026-08-30T10:58:35+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:35 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:35 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:35 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:35 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:38 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:38 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237671. Aug 30 10:58:38 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:38 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:38 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:38 minidsp-shd go-librespot[23913]: go-librespot daemon starting... Aug 30 10:58:38 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="app state loaded" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=info msg="zeroconf server listening on port 33159" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="obtained new client token: AAFVszn3w//Kxb8NBQ15Yz5vIA2gGoIip6FDLSooDAO5v3semzYASTAgprp3lr3aIP3pfMS62/rGN+kkZitJx/dvprGcCTbmUlKUGcfSXuNn1V8CjpodB/3wjsE96qtaRjZ/y2bk3JEr8NKfXek9F34woVw8A90fEkuu26mVO0RUhbw3tQMS8oE1xVlkhkczAllhB7rK3um5AvrawK9exk5cujrii2J5Q91ZKPHEYNSHSh/9yu+8ZGk=" Aug 30 10:58:38 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:38+01:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Aug 30 10:58:39 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:39+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:39 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:39+01:00" level=debug msg="completed challenge" Aug 30 10:58:39 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:39+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:39 minidsp-shd go-librespot[23913]: time="2026-08-30T10:58:39+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:39 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:39 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 10:58:40 minidsp-shd volumio[710]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 10:58:40 minidsp-shd volumio[710]: info: Received Get System Version Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 10:58:40 minidsp-shd volumio[710]: info: Received Get System Info Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:58:40 minidsp-shd volumio[710]: info: Discovery: Getting this device information Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioGetState Aug 30 10:58:40 minidsp-shd volumio[710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:58:41 minidsp-shd volumio[710]: info: Initializing connection to go-librespot Websocket Aug 30 10:58:41 minidsp-shd volumio[710]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Aug 30 10:58:42 minidsp-shd volumio[710]: info: CoreCommandRouter::volumioSeek Aug 30 10:58:42 minidsp-shd volumio[710]: info: CoreStateMachine::seek Aug 30 10:58:42 minidsp-shd volumio[710]: info: [1788083922935] inputs::seek to 0 Aug 30 10:58:42 minidsp-shd volumio[710]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:58:42 minidsp-shd volumio[710]: TypeError: this.sendSpopCommand is not a function Aug 30 10:58:42 minidsp-shd volumio[710]: at inputs.seek (/volumio/app/plugins/music_service/inputs/inputs_real:1:2486) Aug 30 10:58:42 minidsp-shd volumio[710]: at CoreStateMachine.seek (/volumio/app/statemachine.js:1098:20) Aug 30 10:58:42 minidsp-shd volumio[710]: at CoreCommandRouter.volumioSeek (/volumio/app/index.js:1446:28) Aug 30 10:58:42 minidsp-shd volumio[710]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:177:33) Aug 30 10:58:42 minidsp-shd volumio[710]: at Socket.emit (events.js:400:28) Aug 30 10:58:42 minidsp-shd volumio[710]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 30 10:58:42 minidsp-shd volumio[710]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Aug 30 10:58:42 minidsp-shd volumio[710]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:58:43 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Aug 30 10:58:43 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 237672. Aug 30 10:58:43 minidsp-shd systemd[1]: Stopped go-librespot Daemon. Aug 30 10:58:43 minidsp-shd systemd[1]: Started go-librespot Daemon. Aug 30 10:58:43 minidsp-shd go-librespot[23929]: go-librespot daemon starting... Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=info msg="running go-librespot 0.4.0" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="app state loaded" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=info msg="zeroconf server listening on port 35593" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="obtained new client token: AAFHTc3E1G83cd59s6AOgAob60Z4It9dGqo1O/2HXj+BRJjnNUilxcTsxeaLRh5RodPldBr41cYCblDQWpzEV2TthBNsD2LjEdy9vG48v1m2qw54H5gEDev+z1uAmVBgrYYhxH7AoQdFonNU6TzmXWRceS6F89EyEY68uAFqLMmKysTf0su1vFDVbdv0StZHCcLtzasyILlBeX/E3KuMhidBz7S+B9To4kr5GcyV2FkhdL5ChGV2bms=" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:443, retrying with a different AP" error="dial tcp 104.199.65.9:443: connect: connection refused" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="connected to ap-gew1.spotify.com:80" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="completed keyexchange" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=debug msg="completed challenge" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=info msg="authenticated AP" username="jo*pw" Aug 30 10:58:43 minidsp-shd go-librespot[23929]: time="2026-08-30T10:58:43+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Aug 30 10:58:43 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Aug 30 10:58:43 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Aug 30 10:58:43 minidsp-shd sudo[23939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 10:57 Aug 30 10:58:43 minidsp-shd sudo[23939]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 10:55:12 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="0dc70286d49f98e8b92f179804dc6fb6"