Mar 26 09:18:00 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 548. Mar 26 09:18:00 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:00 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:00 retro go-librespot[9558]: go-librespot daemon starting... Mar 26 09:18:00 retro go-librespot[9559]: time="2026-03-26T09:18:00+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:00 retro go-librespot[9559]: time="2026-03-26T09:18:00+01:00" level=debug msg="app state loaded" Mar 26 09:18:00 retro go-librespot[9559]: time="2026-03-26T09:18:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:00 retro go-librespot[9559]: time="2026-03-26T09:18:00+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:00 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:00 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:01 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:01 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:03 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 549. Mar 26 09:18:03 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:03 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:03 retro go-librespot[9567]: go-librespot daemon starting... Mar 26 09:18:03 retro go-librespot[9568]: time="2026-03-26T09:18:03+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:03 retro go-librespot[9568]: time="2026-03-26T09:18:03+01:00" level=debug msg="app state loaded" Mar 26 09:18:03 retro go-librespot[9568]: time="2026-03-26T09:18:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:03 retro go-librespot[9568]: time="2026-03-26T09:18:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:03 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:03 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:04 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:04 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:06 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 550. Mar 26 09:18:06 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:06 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:06 retro go-librespot[9576]: go-librespot daemon starting... Mar 26 09:18:06 retro go-librespot[9577]: time="2026-03-26T09:18:06+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:06 retro go-librespot[9577]: time="2026-03-26T09:18:06+01:00" level=debug msg="app state loaded" Mar 26 09:18:06 retro go-librespot[9577]: time="2026-03-26T09:18:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:06 retro go-librespot[9577]: time="2026-03-26T09:18:06+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:06 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:06 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:07 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:07 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:09 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 551. Mar 26 09:18:09 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:09 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:09 retro go-librespot[9599]: go-librespot daemon starting... Mar 26 09:18:09 retro go-librespot[9600]: time="2026-03-26T09:18:09+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:09 retro go-librespot[9600]: time="2026-03-26T09:18:09+01:00" level=debug msg="app state loaded" Mar 26 09:18:09 retro go-librespot[9600]: time="2026-03-26T09:18:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:09 retro go-librespot[9600]: time="2026-03-26T09:18:09+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:09 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:09 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:10 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:10 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:11 retro systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:11 retro systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 26 09:18:12 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 552. Mar 26 09:18:12 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:12 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:12 retro go-librespot[9608]: go-librespot daemon starting... Mar 26 09:18:12 retro go-librespot[9609]: time="2026-03-26T09:18:12+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:12 retro go-librespot[9609]: time="2026-03-26T09:18:12+01:00" level=debug msg="app state loaded" Mar 26 09:18:12 retro go-librespot[9609]: time="2026-03-26T09:18:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:12 retro go-librespot[9609]: time="2026-03-26T09:18:12+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:12 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:12 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:13 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:13 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:16 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 553. Mar 26 09:18:16 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:16 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:16 retro go-librespot[9617]: go-librespot daemon starting... Mar 26 09:18:16 retro go-librespot[9618]: time="2026-03-26T09:18:16+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:16 retro go-librespot[9618]: time="2026-03-26T09:18:16+01:00" level=debug msg="app state loaded" Mar 26 09:18:16 retro go-librespot[9618]: time="2026-03-26T09:18:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:16 retro go-librespot[9618]: time="2026-03-26T09:18:16+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:16 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:16 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:16 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:16 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:19 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:19 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:19 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 554. Mar 26 09:18:19 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:19 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:19 retro go-librespot[9640]: go-librespot daemon starting... Mar 26 09:18:19 retro go-librespot[9641]: time="2026-03-26T09:18:19+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:19 retro go-librespot[9641]: time="2026-03-26T09:18:19+01:00" level=debug msg="app state loaded" Mar 26 09:18:19 retro go-librespot[9641]: time="2026-03-26T09:18:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:19 retro go-librespot[9641]: time="2026-03-26T09:18:19+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:19 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:19 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:22 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:22 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:22 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 555. Mar 26 09:18:22 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:22 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:22 retro go-librespot[9649]: go-librespot daemon starting... Mar 26 09:18:22 retro go-librespot[9650]: time="2026-03-26T09:18:22+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:22 retro go-librespot[9650]: time="2026-03-26T09:18:22+01:00" level=debug msg="app state loaded" Mar 26 09:18:22 retro go-librespot[9650]: time="2026-03-26T09:18:22+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:22 retro go-librespot[9650]: time="2026-03-26T09:18:22+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:22 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:22 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:25 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:25 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:25 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 556. Mar 26 09:18:25 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:25 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:25 retro go-librespot[9658]: go-librespot daemon starting... Mar 26 09:18:25 retro go-librespot[9659]: time="2026-03-26T09:18:25+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:25 retro go-librespot[9659]: time="2026-03-26T09:18:25+01:00" level=debug msg="app state loaded" Mar 26 09:18:25 retro go-librespot[9659]: time="2026-03-26T09:18:25+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:25 retro go-librespot[9659]: time="2026-03-26T09:18:25+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:25 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:25 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:26 retro systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 26. Mar 26 09:18:26 retro systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 26 09:18:26 retro systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 26 09:18:28 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:28 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:29 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 557. Mar 26 09:18:29 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:29 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:29 retro go-librespot[9675]: go-librespot daemon starting... Mar 26 09:18:29 retro go-librespot[9676]: time="2026-03-26T09:18:29+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:29 retro go-librespot[9676]: time="2026-03-26T09:18:29+01:00" level=debug msg="app state loaded" Mar 26 09:18:29 retro go-librespot[9676]: time="2026-03-26T09:18:29+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:29 retro go-librespot[9676]: time="2026-03-26T09:18:29+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:29 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:29 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:31 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:31 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:32 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 558. Mar 26 09:18:32 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:32 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:32 retro go-librespot[9699]: go-librespot daemon starting... Mar 26 09:18:32 retro systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 26 09:18:32 retro go-librespot[9700]: time="2026-03-26T09:18:32+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:32 retro go-librespot[9700]: time="2026-03-26T09:18:32+01:00" level=debug msg="app state loaded" Mar 26 09:18:32 retro go-librespot[9700]: time="2026-03-26T09:18:32+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:32 retro go-librespot[9700]: time="2026-03-26T09:18:32+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:32 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:32 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:34 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:34 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:35 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 559. Mar 26 09:18:35 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:35 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:35 retro go-librespot[9742]: go-librespot daemon starting... Mar 26 09:18:35 retro go-librespot[9743]: time="2026-03-26T09:18:35+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:35 retro go-librespot[9743]: time="2026-03-26T09:18:35+01:00" level=debug msg="app state loaded" Mar 26 09:18:35 retro go-librespot[9743]: time="2026-03-26T09:18:35+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:35 retro go-librespot[9743]: time="2026-03-26T09:18:35+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:35 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:35 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:37 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:37 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:37 retro bash[9707]: setdatetime-helper: all HTTPS Date fallbacks failed Mar 26 09:18:37 retro systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 26 09:18:37 retro systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 26 09:18:38 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 560. Mar 26 09:18:38 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:38 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:38 retro go-librespot[9764]: go-librespot daemon starting... Mar 26 09:18:38 retro go-librespot[9765]: time="2026-03-26T09:18:38+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:38 retro go-librespot[9765]: time="2026-03-26T09:18:38+01:00" level=debug msg="app state loaded" Mar 26 09:18:38 retro go-librespot[9765]: time="2026-03-26T09:18:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:38 retro go-librespot[9765]: time="2026-03-26T09:18:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:38 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:38 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:40 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:40 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:42 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 561. Mar 26 09:18:42 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:42 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:42 retro go-librespot[9787]: go-librespot daemon starting... Mar 26 09:18:42 retro go-librespot[9788]: time="2026-03-26T09:18:42+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:42 retro go-librespot[9788]: time="2026-03-26T09:18:42+01:00" level=debug msg="app state loaded" Mar 26 09:18:42 retro go-librespot[9788]: time="2026-03-26T09:18:42+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:42 retro go-librespot[9788]: time="2026-03-26T09:18:42+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:42 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:42 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:43 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:43 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:45 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 562. Mar 26 09:18:45 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:45 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:45 retro go-librespot[9796]: go-librespot daemon starting... Mar 26 09:18:45 retro go-librespot[9797]: time="2026-03-26T09:18:45+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:45 retro go-librespot[9797]: time="2026-03-26T09:18:45+01:00" level=debug msg="app state loaded" Mar 26 09:18:45 retro go-librespot[9797]: time="2026-03-26T09:18:45+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:45 retro go-librespot[9797]: time="2026-03-26T09:18:45+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:45 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:45 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:46 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:46 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:48 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 563. Mar 26 09:18:48 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:48 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:48 retro go-librespot[9805]: go-librespot daemon starting... Mar 26 09:18:48 retro go-librespot[9806]: time="2026-03-26T09:18:48+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:48 retro go-librespot[9806]: time="2026-03-26T09:18:48+01:00" level=debug msg="app state loaded" Mar 26 09:18:48 retro go-librespot[9806]: time="2026-03-26T09:18:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:48 retro go-librespot[9806]: time="2026-03-26T09:18:48+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:48 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:48 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:48 retro dhcpcd[855]: eth0: offered 192.168.0.35 from 192.168.0.1 Mar 26 09:18:48 retro dhcpcd[855]: eth0: probing address 192.168.0.35/24 Mar 26 09:18:49 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:49 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:51 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 564. Mar 26 09:18:51 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:51 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:51 retro go-librespot[9829]: go-librespot daemon starting... Mar 26 09:18:51 retro go-librespot[9830]: time="2026-03-26T09:18:51+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:51 retro go-librespot[9830]: time="2026-03-26T09:18:51+01:00" level=debug msg="app state loaded" Mar 26 09:18:51 retro go-librespot[9830]: time="2026-03-26T09:18:51+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:51 retro go-librespot[9830]: time="2026-03-26T09:18:51+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:18:51 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:18:51 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:18:52 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:52 retro volumio[1243]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 09:18:54 retro dhcpcd[855]: eth0: leased 192.168.0.35 for 86400 seconds Mar 26 09:18:54 retro avahi-daemon[829]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.35. Mar 26 09:18:54 retro avahi-daemon[829]: New relevant interface eth0.IPv4 for mDNS. Mar 26 09:18:54 retro avahi-daemon[829]: Registering new address record for 192.168.0.35 on eth0.IPv4. Mar 26 09:18:54 retro dhcpcd[855]: eth0: adding route to 192.168.0.0/24 Mar 26 09:18:54 retro systemd[1]: welcome.service: Deactivated successfully. Mar 26 09:18:54 retro systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 26 09:18:54 retro systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 26 09:18:54 retro dhcpcd[855]: eth0: adding default route via 192.168.0.1 Mar 26 09:18:54 retro systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 26 09:18:54 retro welcome[9857]: Resolved ip:[1] 192.168.0.35 Mar 26 09:18:54 retro systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 26 09:18:54 retro systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 26 09:18:55 retro volumio[1243]: info: Received Get System Info Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 26 09:18:55 retro volumio[1243]: info: Discovery: Getting this device information Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::volumioGetState Mar 26 09:18:55 retro volumio[1243]: info: CorePlayQueue::getTrack 0 Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 26 09:18:55 retro volumio[1243]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 26 09:18:55 retro systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 565. Mar 26 09:18:55 retro systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:55 retro systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 09:18:55 retro go-librespot[9865]: go-librespot daemon starting... Mar 26 09:18:55 retro go-librespot[9866]: time="2026-03-26T09:18:55+01:00" level=info msg="running go-librespot 0.6.2" Mar 26 09:18:55 retro go-librespot[9866]: time="2026-03-26T09:18:55+01:00" level=debug msg="app state loaded" Mar 26 09:18:55 retro go-librespot[9866]: time="2026-03-26T09:18:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 09:18:55 retro volumio[1243]: info: Initializing connection to go-librespot Websocket Mar 26 09:18:55 retro go-librespot[9866]: time="2026-03-26T09:18:55+01:00" level=debug msg="new websocket client" Mar 26 09:18:55 retro volumio[1243]: info: Connection to go-librespot Websocket established Mar 26 09:18:55 retro ntpd[1057]: IO: Listen normally on 3 eth0 192.168.0.35:123 Mar 26 09:18:55 retro ntpd[1057]: IO: new interface(s) found: waking up resolver Mar 26 09:18:55 retro ntpd[1057]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 26 09:18:55 retro volumio5-onboarding[1428]: time=2026-03-26T09:18:55.895+01:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 26 09:18:58 retro volumio[1243]: info: Getting Spotify volume Mar 26 09:18:59 retro volumio[1243]: info: Volumio Network Manager: Network status updated: 1 Mar 26 09:19:10 retro go-librespot[9866]: time="2026-03-26T09:19:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 09:19:10 retro volumio[1243]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 09:19:10 retro systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 09:19:10 retro systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 09:19:10 retro volumio[1243]: Error: socket hang up Mar 26 09:19:10 retro volumio[1243]: at connResetException (node:internal/errors:720:14) Mar 26 09:19:10 retro volumio[1243]: at Socket.socketOnEnd (node:_http_client:519:23) Mar 26 09:19:10 retro volumio[1243]: at Socket.emit (node:events:526:35) Mar 26 09:19:10 retro volumio[1243]: at endReadableNT (node:internal/streams/readable:1376:12) Mar 26 09:19:10 retro volumio[1243]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 26 09:19:10 retro volumio[1243]: code: 'ECONNRESET', Mar 26 09:19:10 retro volumio[1243]: response: undefined Mar 26 09:19:10 retro volumio[1243]: } Mar 26 09:19:10 retro volumio[1243]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 09:19:10 retro upmpdcli[9925]: writing RSA key Mar 26 09:19:10 retro sudo[9932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 09:18' Mar 26 09:19:10 retro sudo[9932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"