Oct 03 12:21:00 spla-repro dhcpcd[808]: eth0: leased 192.168.200.203 for 300 seconds Oct 03 12:21:00 spla-repro systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 03 12:21:00 spla-repro systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 03 12:21:00 spla-repro systemd[1]: welcome.service: Deactivated successfully. Oct 03 12:21:00 spla-repro systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 03 12:21:00 spla-repro systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 03 12:21:00 spla-repro systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 03 12:21:00 spla-repro welcome[29397]: Resolved ip:[1] 192.168.200.203 Oct 03 12:21:00 spla-repro systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 03 12:21:00 spla-repro systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 03 12:21:00 spla-repro volumio[28824]: info: Received Get System Info Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 12:21:00 spla-repro volumio[28824]: info: Discovery: Getting this device information Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:00 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 03 12:21:00 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 03 12:21:00 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:01 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:01 spla-repro volumio5-onboarding[13794]: time=2026-10-03T12:21:01.327+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 03 12:21:01 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Oct 03 12:21:01 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:02 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:02 spla-repro go-librespot[29403]: go-librespot daemon starting... Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=debug msg="app state loaded" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02: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]" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02: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]" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02: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]" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=info msg="zeroconf server listening on port 39041" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=debug msg="obtained new client token: AAHSlIK0uk39BL49AP3oZAtby3kHJSrxfhBiZCLhdxbIXO44eAJHSEq3GpiQg1vysB+CkhYdvAT/G8dpb4/fK+saF2/5KYJttczc+amJCXs5aVmw0cPsmNjgVExmZS4isWbU/DhERtOkI6sjbnXhEP4nYRdGBuCUeU2oDfc/kgLlRDdb+k6Jo8Va4IJ9jrAhcKlKLvnGZ/lPU8cftfWz8fJfFkrySEOlzsFlBhH0mYuwgkHM3ipJALWdJQ==" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=debug msg="completed challenge" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:02 spla-repro go-librespot[29404]: time="2026-10-03T12:21:02+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:02 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:02 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:04 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:04 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:05 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Oct 03 12:21:05 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:06 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:06 spla-repro go-librespot[29430]: go-librespot daemon starting... Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=debug msg="app state loaded" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02: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]" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02: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]" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02: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]" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=info msg="zeroconf server listening on port 41147" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=debug msg="obtained new client token: AAGljM0Ie/ofGZe5Jg0/mbVZ5sYLh7exgr2zN0vJtN9caS9bELfbQJAlNwTGIgchNDMWvA3qgwIfSQK2daRIbTS2ZJt16ALxtkfCJyjmrJ6pR0RQBfP5ApMfNEjSQ9eGxG8RgQS5p9EGyxK9b71ir3PuFMGiACafG3+f6mVhQFn5ZgaEHvp+hdHry7hTVfcckp1ZdtAd6EW6WZbFWo1rG3/4Xcr3KPvPKm78WtkE8crW8wvv72ic3DwH0Q==" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=debug msg="completed challenge" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:06 spla-repro go-librespot[29431]: time="2026-10-03T12:21:06+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:06 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:06 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:07 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:07 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:08 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:08 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:09 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Oct 03 12:21:09 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:09 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:10 spla-repro go-librespot[29440]: go-librespot daemon starting... Oct 03 12:21:10 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:10 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=debug msg="app state loaded" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02: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]" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02: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]" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02: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]" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=info msg="zeroconf server listening on port 40515" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=debug msg="obtained new client token: AAGoBMJuSFwssG75iFePpyDzznTODs40sHjsn9N9n14verCREsXxR5adECtxZx+5av7uqSKfC4f33qEku0F7PC+e/jRotOe4r2Up2A7zlPtb2fT521DIVqGRumVSta43FQkBz51uJX+8CJQOJy6JuTlHq4FQi39sekIyjbwCyjJhQkyZoDyWDkTxAirY0EmD6u6MUqJ6Fuj6Oap4vl+o/HEyVWFhzzhbpx4a4tE2EgFuamyvwmk2lCC9xQ==" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=debug msg="completed challenge" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:10 spla-repro go-librespot[29441]: time="2026-10-03T12:21:10+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:10 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:10 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:13 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:13 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:13 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Oct 03 12:21:13 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:14 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:14 spla-repro go-librespot[29451]: go-librespot daemon starting... Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=debug msg="app state loaded" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02: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]" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02: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]" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02: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]" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=info msg="zeroconf server listening on port 39877" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=debug msg="obtained new client token: AAGFLL5ePObV15KSJv6I1tURxExoiLc6y8Z1Tp8XSym5PkVNOWG/Pjaj5875PTFcZcR7JNTDfkmgdJETALQ5JBuq8EGW2uC4rf4w5SDgPdKPR/QYoH0dusQQ2T45Ro/R0YdmMYUFn1w1oPgdrK2NqZ4JYfqwSyNpWyy42plC9XFdiI5Xpn2BuBWvR3V5YpGcmSlZnj0C0itqgQ+JPxL2AWfKc9vy4wNWgNNMCUsXNWmTFARycE7mkw8yXw==" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=debug msg="completed challenge" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:14 spla-repro go-librespot[29452]: time="2026-10-03T12:21:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:14 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:14 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:16 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:16 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:18 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Oct 03 12:21:18 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:18 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:18 spla-repro go-librespot[29477]: go-librespot daemon starting... Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=debug msg="app state loaded" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02: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]" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02: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]" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02: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]" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=info msg="zeroconf server listening on port 44225" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=debug msg="obtained new client token: AAG0CG4AjKaebVo7Oo/e/g/KO3y3GWbNhk25NXMj6+Yngar2If5kVzG0NDxG82NZcKKH45GgK6JYN1G3T84PKI9ARqXD8D9ZBt3eb4zUaGzmCdJtgR+J1i54fny0ZE/jXrG8hl153hz1DbRdPTlRVOJQFgjDY7xdwVRYV24M01oJUMrFDJEnJ8zjCgd13yEB+rzSFvxaal4N3DlpJWa9yvHUljW2kGCSfZEnHvRHEksjjx9rgCpaIH94Dg==" Oct 03 12:21:18 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:18 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:18 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:18 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=debug msg="completed challenge" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:18 spla-repro go-librespot[29478]: time="2026-10-03T12:21:18+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:18 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:18 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:19 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:19 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:22 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:22 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:22 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Oct 03 12:21:22 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:22 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:22 spla-repro go-librespot[29489]: go-librespot daemon starting... Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=debug msg="app state loaded" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02: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]" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02: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]" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02: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]" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=info msg="zeroconf server listening on port 35389" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=debug msg="obtained new client token: AAGJKXoEB0gLrbnEx7+JFD4frHKQzezwp02g05O4PwK0SJXp5Qqbtw+/QGuPpr/uMl1a8qJPf84F9ZDtKz+9ve/wsZJiMm/h/aiY25tH0tp3p7HIJS2INT5hVw0nl23XVb3aOiGqW20NoR59Dkk+wyBECKXICQwPHgbLtsHKoGr9hdFOyuxu1Q+RT9hSfktcdMq71KWi4loa1IQB0YLxX+uGJ/Xoid28kKURiEnbC6EkEkECWvGdRIU7Zg==" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=debug msg="completed challenge" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:22 spla-repro go-librespot[29490]: time="2026-10-03T12:21:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:22 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:22 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:25 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:25 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:26 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Oct 03 12:21:26 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:26 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:26 spla-repro go-librespot[29513]: go-librespot daemon starting... Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=debug msg="app state loaded" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02: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]" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02: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]" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02: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]" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=info msg="zeroconf server listening on port 38087" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=debug msg="obtained new client token: AAGkPoChRQ1c7c6BIHLeF76ywm9VhRdhoYp8strYA2b2MUXp3/Dhk8BaOkxaDcXYiG/iVF/UiNHNxDfgzwg06WNKjNpPmJdwmbX/lV7eoeh9ug53NO7LtH+3emWN3uMxZ+npAB6xM4C7907QPHVjeryoW9Brg4uc2tomLFemjyiLn6XOnKf5Ib5FUfksFMtBCx+lnA7gHbX71pypbHALBLUfFSccYVIg5Caj2xuVkfAstOLQp9idMRWmBw==" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=debug msg="completed challenge" Oct 03 12:21:26 spla-repro go-librespot[29514]: time="2026-10-03T12:21:26+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:27 spla-repro go-librespot[29514]: time="2026-10-03T12:21:27+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:27 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:27 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:28 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:28 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:28 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:28 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:30 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Oct 03 12:21:30 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:30 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:30 spla-repro go-librespot[29524]: go-librespot daemon starting... Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=debug msg="app state loaded" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02: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]" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02: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]" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02: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]" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=info msg="zeroconf server listening on port 45563" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=debug msg="obtained new client token: AAGOtczFgYBBFtHRJQoX7pJ7yux0nLvZH8/LUYtNFhQGljGvQ6Ligw8yOUn/Q5LASgNAl8AYDtI6nbHXXQaoqyzFM/3fuzHd7SI0iEmHL6+HBZURWgOyWoSoIE+Ysj1RBpxIfAbc6II05L+/7FkZ0zTGRIsT3qaDOXQ2pt0VC3m8J46u1XZjpbaWredV/rHAdklYIXRO7UOrIcZaEhWBlEsCL6Sp2qZ3vltzEwjbOMy6yxo0H+z3Qn3AEw==" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=debug msg="completed challenge" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:30 spla-repro go-librespot[29525]: time="2026-10-03T12:21:30+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:30 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:30 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:31 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:31 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:31 spla-repro systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Oct 03 12:21:31 spla-repro systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Oct 03 12:21:31 spla-repro systemd[1]: welcome.service: Deactivated successfully. Oct 03 12:21:31 spla-repro systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 03 12:21:31 spla-repro systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 03 12:21:32 spla-repro systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 03 12:21:32 spla-repro welcome[29552]: Resolved ip:[1] 192.168.200.203 Oct 03 12:21:32 spla-repro systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 03 12:21:32 spla-repro systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Oct 03 12:21:32 spla-repro volumio[28824]: info: Received Get System Info Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 03 12:21:32 spla-repro volumio[28824]: info: Discovery: Getting this device information Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:32 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 03 12:21:32 spla-repro volumio[28824]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 03 12:21:33 spla-repro volumio5-onboarding[13794]: time=2026-10-03T12:21:33.461+02:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 03 12:21:34 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:34 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:34 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Oct 03 12:21:34 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:34 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:34 spla-repro go-librespot[29557]: go-librespot daemon starting... Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=debug msg="app state loaded" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02: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]" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02: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]" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02: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]" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=info msg="zeroconf server listening on port 35649" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=debug msg="obtained new client token: AAEiKUG3+xOcRwP3HAd1uUEASIGK7vwKdQbkjwmB6cXJmjo/nSZQCNQI3VZudDn105YSpxtQV6XbgpkRLUGS89kJvVj9hEP6UcHNkSgR78cWwDOd4nww1Q8wO1xNA3N94SS0PxNFa350O9YQynej7SXxH0d5Pt+y04712XxNrCb109UZ5Aae7q/eBaPxF7ffFIFFQYlgKnU04lVT5HTTf4RtC6zIQ/OJhkgrcDUC2yF0zETilqzGp/Lq2A==" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02: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" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=debug msg="connected to ap-gew1.spotify.com:443" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=debug msg="completed challenge" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:34 spla-repro go-librespot[29558]: time="2026-10-03T12:21:34+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:34 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:34 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:37 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:37 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:38 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Oct 03 12:21:38 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:38 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:38 spla-repro go-librespot[29581]: go-librespot daemon starting... Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=debug msg="app state loaded" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02: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]" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02: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]" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02: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]" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=info msg="zeroconf server listening on port 44433" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=debug msg="obtained new client token: AAFx23yavtctULmy45ZYHmTInPizEQLIZt6OmGDuRJU3wPe15HedeZxktRNAex4uRSqCWidl7RX1+6e5d4xQGB10n0TInUg6AZZ555JI8D8QqR3s+6ajL/r0cEYJygYuZ7SmF5BGeeA0pdV4DtrQAFJgwZLmkmZVaFd8Z+YzSr/V06NDj94+I8XD6o5KaP1YzYYIq6fpnbWMZFEEiKYARvJiRzeSkKq9c/acUVKo2F+XQ2YsheS4/VhhAw==" Oct 03 12:21:38 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:38 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:38 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:38 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=debug msg="completed challenge" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:38 spla-repro go-librespot[29582]: time="2026-10-03T12:21:38+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:38 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:38 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:40 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:40 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:42 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Oct 03 12:21:42 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:42 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:42 spla-repro go-librespot[29592]: go-librespot daemon starting... Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=debug msg="app state loaded" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02: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]" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02: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]" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02: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]" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=info msg="zeroconf server listening on port 42633" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=debug msg="obtained new client token: AAGU8dk3sa/zzVbYOI08Uk1HvChaenJcjXrJ5U2voDWHZ8hQMhECNlbMMDXyMep5NqyZMlyrRn31QzFf8VgUMFY/9KZq4qzMldD02sPYX6Ov2QEg+em0NJHBfJRpvmZN2M9Oq5Xt4MtgW+fJoeERFLm5EvIMDeMhivywo+D5m8aGfuU8ay00GRe4I1TenCaPdHtfKmCnsSiCzBTcX2P/7Ew/nTa8PEldS781d2qj217TudmTiE50ZqdsiA==" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=debug msg="completed challenge" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:42 spla-repro go-librespot[29593]: time="2026-10-03T12:21:42+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:42 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:42 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:43 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:43 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:45 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Oct 03 12:21:45 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:46 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:46 spla-repro go-librespot[29604]: go-librespot daemon starting... Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=debug msg="app state loaded" Oct 03 12:21:46 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:46 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02: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]" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02: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]" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02: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]" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=info msg="zeroconf server listening on port 44493" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=debug msg="obtained new client token: AAFOKw37/iyq7qNhAJ2P0b03ImXFbEqZhGBgnm7j7jrcaFmnHS1A54xaF7RzX/rY/UmFp69/tymv8+kfILWNoryGbateL58xCLzgZ+975TDOSzL/Fj7WrrAZ8bsPfLtak2POmo9ZH1Mrm6dL9rRA4l8Y2tKB1dJZJMaYPPDCyk1GRXoddRq8KLQqeEBHTawsD8I5MCXGBKceR+dSHD5p1KkJSXoen2BUTqq1T5SLtQqwFmViuFyxrc7AAA==" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=debug msg="completed challenge" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:46 spla-repro go-librespot[29613]: time="2026-10-03T12:21:46+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:46 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:46 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:48 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:48 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:49 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:49 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:49 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Oct 03 12:21:49 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:50 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:50 spla-repro go-librespot[29628]: go-librespot daemon starting... Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=debug msg="app state loaded" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02: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]" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02: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]" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02: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]" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=info msg="zeroconf server listening on port 40815" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=debug msg="obtained new client token: AAE8UJ/5KF62ptLxHXGv/n8UiUnyyos17EFsYspbpqlWncxFNuY6JkJc4+U2jNQEdQnSE8T5e08tBmJLy2GIieHdg0saJRHVByCSVODKY9PP5YFRALCk2zrxoV2JftUXnEKa8dzq8t5lnVlvO//0/KpDiQu65Gtshxg+8QTso63BXkzWE5peTLyJhV77bS2B9p++/2+bejZ5vKe5EKzAZM251w70GhqP+GkOvZd90iB/b8g1ODyofsXAVA==" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=debug msg="completed challenge" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:50 spla-repro go-librespot[29629]: time="2026-10-03T12:21:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:50 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:50 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:52 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:52 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:53 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Oct 03 12:21:53 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:54 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:54 spla-repro go-librespot[29638]: go-librespot daemon starting... Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=debug msg="app state loaded" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02: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]" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02: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]" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02: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]" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=info msg="zeroconf server listening on port 45851" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=debug msg="obtained new client token: AAFBZDtRUksDd6x22bJdUL3O38nHYb8h2nzXeVM9pMfAyMlXn+n9QGUKr33ga4kVNulCDY7Ql057EKSoul7G9uRlEHH1czhMQtQlqun7fQ1RK6nw6HEJ4aP1UY6vfOJ6rOZBzChhBZYYVaIKJO6bt9jHESOcsf/3ZxSuluEC4IVJacCJpQLmCHOnlSrO8buRgqpyDR+yo4xgErnvRi5tbA0bxIJiE4I+nWztrkIlaHNJvNR6eXYSXvjiOQ==" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=debug msg="completed challenge" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:54 spla-repro go-librespot[29639]: time="2026-10-03T12:21:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:54 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:54 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:21:55 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:55 spla-repro volumio[28824]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:21:57 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Oct 03 12:21:57 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:57 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:21:57 spla-repro go-librespot[29662]: go-librespot daemon starting... Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=info msg="running go-librespot 0.7.1" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="app state loaded" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 03 12:21:58 spla-repro volumio[28824]: info: Initializing connection to go-librespot Websocket Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="new websocket client" Oct 03 12:21:58 spla-repro volumio[28824]: info: Connection to go-librespot Websocket established Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02: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]" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02: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]" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02: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]" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=info msg="zeroconf server listening on port 37963" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="obtained new client token: AAH0WI5u4HNa73f7YrWPanpOBgKPOcziXTowkEgx3ngOQt61k9l/kRimzN7XcSdqxfFvBuy/ID+IGoQM+fGRnBsUDfAq4DWmZQ3u7F611op10v+/ivlCRrLd7OmM3ms7xs3f+mumEdkRx+FhkpzivVCDXb1gW5HWip5pNgUoHAbfWCV8RN3F8ujSxCx5tTIMS33eVF1hjtqv51vVkyakL5dh6jlcGjn3vNboD07cHGXSccMMAbQL+ykdhQ==" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="completed keyexchange" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=debug msg="completed challenge" Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=info msg="authenticated AP" username="4b*********************lb" Oct 03 12:21:58 spla-repro volumio[28824]: info: CoreCommandRouter::volumioGetState Oct 03 12:21:58 spla-repro volumio[28824]: info: CorePlayQueue::getTrack 0 Oct 03 12:21:58 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:58 spla-repro volumio[28824]: info: Listing playlists Oct 03 12:21:58 spla-repro go-librespot[29663]: time="2026-10-03T12:21:58+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating with login5: failed authenticating with login5: INVALID_CREDENTIALS" Oct 03 12:21:58 spla-repro volumio[28824]: info: Connection to go-librespot Websocket closed Oct 03 12:21:58 spla-repro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Oct 03 12:21:58 spla-repro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Oct 03 12:22:01 spla-repro volumio[28824]: info: Getting Spotify volume Oct 03 12:22:01 spla-repro volumio[28824]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 12:22:01 spla-repro volumio[28824]: Error: connect ECONNREFUSED 127.0.0.1:9879 Oct 03 12:22:01 spla-repro volumio[28824]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 03 12:22:01 spla-repro volumio[28824]: errno: -111, Oct 03 12:22:01 spla-repro volumio[28824]: code: 'ECONNREFUSED', Oct 03 12:22:01 spla-repro volumio[28824]: syscall: 'connect', Oct 03 12:22:01 spla-repro volumio[28824]: address: '127.0.0.1', Oct 03 12:22:01 spla-repro volumio[28824]: port: 9879, Oct 03 12:22:01 spla-repro volumio[28824]: response: undefined Oct 03 12:22:01 spla-repro volumio[28824]: } Oct 03 12:22:01 spla-repro volumio[28824]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 03 12:22:01 spla-repro sudo[29689]: volumio : unable to resolve host spla-repro: System error Oct 03 12:22:01 spla-repro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Oct 03 12:22:01 spla-repro sudo[29689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-03 12:21' Oct 03 12:22:01 spla-repro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:22:01 spla-repro sudo[29689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 03 12:22:02 spla-repro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Oct 03 12:22:02 spla-repro go-librespot[29690]: go-librespot daemon starting... PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"