May 28 10:15:00 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 258. May 28 10:15:00 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:00 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:00 volumio go-librespot[12019]: go-librespot daemon starting... May 28 10:15:00 volumio go-librespot[12020]: time="2026-05-28T10:15:00+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:00 volumio go-librespot[12020]: time="2026-05-28T10:15:00+02:00" level=debug msg="app state loaded" May 28 10:15:00 volumio go-librespot[12020]: time="2026-05-28T10:15:00+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:00 volumio go-librespot[12020]: time="2026-05-28T10:15:00+02: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" May 28 10:15:00 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:00 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:01 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:01 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 259. May 28 10:15:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:04 volumio go-librespot[12026]: go-librespot daemon starting... May 28 10:15:04 volumio go-librespot[12027]: time="2026-05-28T10:15:04+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:04 volumio go-librespot[12027]: time="2026-05-28T10:15:04+02:00" level=debug msg="app state loaded" May 28 10:15:04 volumio go-librespot[12027]: time="2026-05-28T10:15:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:04 volumio go-librespot[12027]: time="2026-05-28T10:15:04+02: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" May 28 10:15:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:04 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:04 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:07 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:07 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 260. May 28 10:15:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:07 volumio go-librespot[12034]: go-librespot daemon starting... May 28 10:15:07 volumio go-librespot[12035]: time="2026-05-28T10:15:07+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:07 volumio go-librespot[12035]: time="2026-05-28T10:15:07+02:00" level=debug msg="app state loaded" May 28 10:15:07 volumio go-librespot[12035]: time="2026-05-28T10:15:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:07 volumio go-librespot[12035]: time="2026-05-28T10:15:07+02: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" May 28 10:15:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:10 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:10 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 261. May 28 10:15:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:10 volumio go-librespot[12059]: go-librespot daemon starting... May 28 10:15:10 volumio go-librespot[12060]: time="2026-05-28T10:15:10+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:10 volumio go-librespot[12060]: time="2026-05-28T10:15:10+02:00" level=debug msg="app state loaded" May 28 10:15:10 volumio go-librespot[12060]: time="2026-05-28T10:15:10+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:10 volumio go-librespot[12060]: time="2026-05-28T10:15:10+02: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" May 28 10:15:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:13 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:13 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:13 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 262. May 28 10:15:13 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:13 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:13 volumio go-librespot[12066]: go-librespot daemon starting... May 28 10:15:13 volumio go-librespot[12067]: time="2026-05-28T10:15:13+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:13 volumio go-librespot[12067]: time="2026-05-28T10:15:13+02:00" level=debug msg="app state loaded" May 28 10:15:13 volumio go-librespot[12067]: time="2026-05-28T10:15:13+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:13 volumio go-librespot[12067]: time="2026-05-28T10:15:13+02: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" May 28 10:15:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:16 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:16 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 263. May 28 10:15:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:17 volumio go-librespot[12073]: go-librespot daemon starting... May 28 10:15:17 volumio go-librespot[12074]: time="2026-05-28T10:15:17+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:17 volumio go-librespot[12074]: time="2026-05-28T10:15:17+02:00" level=debug msg="app state loaded" May 28 10:15:17 volumio go-librespot[12074]: time="2026-05-28T10:15:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:17 volumio go-librespot[12074]: time="2026-05-28T10:15:17+02: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" May 28 10:15:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:19 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:19 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 264. May 28 10:15:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:20 volumio go-librespot[12094]: go-librespot daemon starting... May 28 10:15:20 volumio go-librespot[12095]: time="2026-05-28T10:15:20+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:20 volumio go-librespot[12095]: time="2026-05-28T10:15:20+02:00" level=debug msg="app state loaded" May 28 10:15:20 volumio go-librespot[12095]: time="2026-05-28T10:15:20+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:20 volumio go-librespot[12095]: time="2026-05-28T10:15:20+02: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" May 28 10:15:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:22 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:22 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 265. May 28 10:15:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:23 volumio go-librespot[12102]: go-librespot daemon starting... May 28 10:15:23 volumio go-librespot[12103]: time="2026-05-28T10:15:23+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:23 volumio go-librespot[12103]: time="2026-05-28T10:15:23+02:00" level=debug msg="app state loaded" May 28 10:15:23 volumio go-librespot[12103]: time="2026-05-28T10:15:23+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:23 volumio go-librespot[12103]: time="2026-05-28T10:15:23+02: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" May 28 10:15:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:25 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:25 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:26 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 266. May 28 10:15:26 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:26 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:26 volumio go-librespot[12109]: go-librespot daemon starting... May 28 10:15:26 volumio go-librespot[12110]: time="2026-05-28T10:15:26+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:26 volumio go-librespot[12110]: time="2026-05-28T10:15:26+02:00" level=debug msg="app state loaded" May 28 10:15:26 volumio go-librespot[12110]: time="2026-05-28T10:15:26+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:26 volumio go-librespot[12110]: time="2026-05-28T10:15:26+02: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" May 28 10:15:26 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:26 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:28 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:28 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 267. May 28 10:15:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:30 volumio go-librespot[12133]: go-librespot daemon starting... May 28 10:15:30 volumio go-librespot[12134]: time="2026-05-28T10:15:30+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:30 volumio go-librespot[12134]: time="2026-05-28T10:15:30+02:00" level=debug msg="app state loaded" May 28 10:15:30 volumio go-librespot[12134]: time="2026-05-28T10:15:30+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:30 volumio go-librespot[12134]: time="2026-05-28T10:15:30+02: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" May 28 10:15:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:31 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:31 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 268. May 28 10:15:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:33 volumio go-librespot[12142]: go-librespot daemon starting... May 28 10:15:33 volumio go-librespot[12143]: time="2026-05-28T10:15:33+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:33 volumio go-librespot[12143]: time="2026-05-28T10:15:33+02:00" level=debug msg="app state loaded" May 28 10:15:33 volumio go-librespot[12143]: time="2026-05-28T10:15:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:33 volumio go-librespot[12143]: time="2026-05-28T10:15:33+02: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" May 28 10:15:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:34 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:34 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 269. May 28 10:15:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:36 volumio go-librespot[12150]: go-librespot daemon starting... May 28 10:15:36 volumio go-librespot[12151]: time="2026-05-28T10:15:36+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:36 volumio go-librespot[12151]: time="2026-05-28T10:15:36+02:00" level=debug msg="app state loaded" May 28 10:15:36 volumio go-librespot[12151]: time="2026-05-28T10:15:36+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:36 volumio go-librespot[12151]: time="2026-05-28T10:15:36+02: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" May 28 10:15:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:37 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:37 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:39 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 270. May 28 10:15:39 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:39 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:39 volumio go-librespot[12172]: go-librespot daemon starting... May 28 10:15:39 volumio go-librespot[12173]: time="2026-05-28T10:15:39+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:39 volumio go-librespot[12173]: time="2026-05-28T10:15:39+02:00" level=debug msg="app state loaded" May 28 10:15:39 volumio go-librespot[12173]: time="2026-05-28T10:15:39+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:39 volumio go-librespot[12173]: time="2026-05-28T10:15:39+02: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" May 28 10:15:39 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:39 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:40 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:40 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 271. May 28 10:15:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:43 volumio go-librespot[12180]: go-librespot daemon starting... May 28 10:15:43 volumio go-librespot[12181]: time="2026-05-28T10:15:43+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:43 volumio go-librespot[12181]: time="2026-05-28T10:15:43+02:00" level=debug msg="app state loaded" May 28 10:15:43 volumio go-librespot[12181]: time="2026-05-28T10:15:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:43 volumio go-librespot[12181]: time="2026-05-28T10:15:43+02: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" May 28 10:15:43 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:43 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:43 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:43 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:44 volumio dhcpcd[802]: wlan0: offered 192.168.0.74 from 192.168.0.1 May 28 10:15:44 volumio dhcpcd[802]: wlan0: probing address 192.168.0.74/24 May 28 10:15:46 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:46 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: AggregateError May 28 10:15:46 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 272. May 28 10:15:46 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:46 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:46 volumio go-librespot[12188]: go-librespot daemon starting... May 28 10:15:46 volumio go-librespot[12189]: time="2026-05-28T10:15:46+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:46 volumio go-librespot[12189]: time="2026-05-28T10:15:46+02:00" level=debug msg="app state loaded" May 28 10:15:46 volumio go-librespot[12189]: time="2026-05-28T10:15:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:46 volumio go-librespot[12189]: time="2026-05-28T10:15:46+02: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" May 28 10:15:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:15:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:15:49 volumio dhcpcd[802]: wlan0: leased 192.168.0.74 for 120 seconds May 28 10:15:49 volumio avahi-daemon[1186]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.74. May 28 10:15:49 volumio avahi-daemon[1186]: New relevant interface wlan0.IPv4 for mDNS. May 28 10:15:49 volumio avahi-daemon[1186]: Registering new address record for 192.168.0.74 on wlan0.IPv4. May 28 10:15:49 volumio dhcpcd[802]: wlan0: adding route to 192.168.0.0/24 May 28 10:15:49 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. May 28 10:15:49 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... May 28 10:15:49 volumio systemd[1]: welcome.service: Deactivated successfully. May 28 10:15:49 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. May 28 10:15:49 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... May 28 10:15:49 volumio dhcpcd[802]: wlan0: adding default route via 192.168.0.1 May 28 10:15:49 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... May 28 10:15:49 volumio welcome[12228]: Resolved ip:[1] 192.168.0.74 May 28 10:15:49 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. May 28 10:15:49 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. May 28 10:15:49 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:49 volumio volumio[8506]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 28 10:15:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 273. May 28 10:15:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. May 28 10:15:49 volumio go-librespot[12241]: go-librespot daemon starting... May 28 10:15:49 volumio go-librespot[12242]: time="2026-05-28T10:15:49+02:00" level=info msg="running go-librespot 0.4.0" May 28 10:15:49 volumio go-librespot[12242]: time="2026-05-28T10:15:49+02:00" level=debug msg="app state loaded" May 28 10:15:49 volumio go-librespot[12242]: time="2026-05-28T10:15:49+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 28 10:15:50 volumio volumio[8506]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 28 10:15:50 volumio ntpd[912]: IO: Listen normally on 4 wlan0 192.168.0.74:123 May 28 10:15:50 volumio ntpd[912]: IO: new interface(s) found: waking up resolver May 28 10:15:50 volumio ntpd[912]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 28 10:15:52 volumio volumio[8506]: info: Initializing connection to go-librespot Websocket May 28 10:15:52 volumio go-librespot[12242]: time="2026-05-28T10:15:52+02:00" level=debug msg="new websocket client" May 28 10:15:52 volumio volumio[8506]: info: Connection to go-librespot Websocket established May 28 10:15:55 volumio volumio[8506]: info: Getting Spotify volume May 28 10:15:57 volumio volumio[8506]: info: Volumio Network Manager: Network status updated: 2 May 28 10:16:00 volumio volumio[8506]: info: CoreCommandRouter::volumioGetState May 28 10:16:00 volumio volumio[8506]: info: CorePlayQueue::getTrack 0 May 28 10:16:00 volumio volumio[8506]: info: Listing playlists May 28 10:16:00 volumio volumio[8506]: info: Listing playlists May 28 10:16:10 volumio volumio[8506]: info: CoreCommandRouter::volumioGetState May 28 10:16:10 volumio volumio[8506]: info: CorePlayQueue::getTrack 0 May 28 10:16:14 volumio ntpd[912]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 28 10:16:14 volumio ntpd[912]: DNS: dns_check: DNS error: -11, System error May 28 10:16:14 volumio ntpd[912]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 May 28 10:16:14 volumio ntpd[912]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 28 10:16:15 volumio ntpd[912]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 5.1.56.123 May 28 10:16:15 volumio ntpd[912]: DNS: Pool skipping: 162.159.200.123 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 46.28.110.153 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 85.163.168.227 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 2001:15e8:110:7d00::82a May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 2a02:c60:600::225:0 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 2a05:5502:12:11::123 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 2a12:bec4:1da0:3e::123 May 28 10:16:15 volumio ntpd[912]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 28 10:16:15 volumio go-librespot[12242]: time="2026-05-28T10:16:15+02: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" May 28 10:16:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE May 28 10:16:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 28 10:16:15 volumio volumio[8506]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 10:16:15 volumio volumio[8506]: Error: socket hang up May 28 10:16:15 volumio volumio[8506]: at connResetException (node:internal/errors:720:14) May 28 10:16:15 volumio volumio[8506]: at Socket.socketOnEnd (node:_http_client:519:23) May 28 10:16:15 volumio volumio[8506]: at Socket.emit (node:events:526:35) May 28 10:16:15 volumio volumio[8506]: at endReadableNT (node:internal/streams/readable:1376:12) May 28 10:16:15 volumio volumio[8506]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { May 28 10:16:15 volumio volumio[8506]: code: 'ECONNRESET', May 28 10:16:15 volumio volumio[8506]: response: undefined May 28 10:16:15 volumio volumio[8506]: } May 28 10:16:15 volumio volumio[8506]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 10:16:15 volumio ntpd[912]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 28 10:16:15 volumio ntpd[912]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 28 10:16:15 volumio ntpd[912]: DNS: Pool skipping: 193.165.135.230 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 194.182.77.109 May 28 10:16:15 volumio ntpd[912]: DNS: Pool taking: 80.211.220.41 May 28 10:16:15 volumio ntpd[912]: DNS: Pool skipping: 5.1.56.123 May 28 10:16:15 volumio ntpd[912]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 May 28 10:16:16 volumio sudo[12298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-28 10:15' May 28 10:16:16 volumio sudo[12298]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"