Feb 25 19:21:00 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 326. Feb 25 19:21:00 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:00 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:00 bcik go-librespot[14422]: go-librespot daemon starting... Feb 25 19:21:00 bcik go-librespot[14423]: time="2026-02-25T19:21:00+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:00 bcik go-librespot[14423]: time="2026-02-25T19:21:00+01:00" level=debug msg="app state loaded" Feb 25 19:21:00 bcik go-librespot[14423]: time="2026-02-25T19:21:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:00 bcik go-librespot[14423]: time="2026-02-25T19:21: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" Feb 25 19:21:00 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:00 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:02 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:02 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:03 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 327. Feb 25 19:21:03 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:03 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:03 bcik go-librespot[14430]: go-librespot daemon starting... Feb 25 19:21:03 bcik go-librespot[14431]: time="2026-02-25T19:21:03+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:03 bcik go-librespot[14431]: time="2026-02-25T19:21:03+01:00" level=debug msg="app state loaded" Feb 25 19:21:03 bcik go-librespot[14431]: time="2026-02-25T19:21:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:03 bcik go-librespot[14431]: time="2026-02-25T19:21: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" Feb 25 19:21:03 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:03 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:05 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:05 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:06 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 328. Feb 25 19:21:06 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:06 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:06 bcik go-librespot[14451]: go-librespot daemon starting... Feb 25 19:21:06 bcik go-librespot[14452]: time="2026-02-25T19:21:06+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:06 bcik go-librespot[14452]: time="2026-02-25T19:21:06+01:00" level=debug msg="app state loaded" Feb 25 19:21:06 bcik go-librespot[14452]: time="2026-02-25T19:21:06+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:06 bcik go-librespot[14452]: time="2026-02-25T19:21: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" Feb 25 19:21:06 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:06 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:08 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:08 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:10 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 329. Feb 25 19:21:10 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:10 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:10 bcik go-librespot[14458]: go-librespot daemon starting... Feb 25 19:21:10 bcik go-librespot[14459]: time="2026-02-25T19:21:10+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:10 bcik go-librespot[14459]: time="2026-02-25T19:21:10+01:00" level=debug msg="app state loaded" Feb 25 19:21:10 bcik go-librespot[14459]: time="2026-02-25T19:21:10+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:10 bcik go-librespot[14459]: time="2026-02-25T19:21: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" Feb 25 19:21:10 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:10 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:11 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:11 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:13 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 330. Feb 25 19:21:13 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:13 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:13 bcik go-librespot[14465]: go-librespot daemon starting... Feb 25 19:21:13 bcik go-librespot[14466]: time="2026-02-25T19:21:13+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:13 bcik go-librespot[14466]: time="2026-02-25T19:21:13+01:00" level=debug msg="app state loaded" Feb 25 19:21:13 bcik go-librespot[14466]: time="2026-02-25T19:21:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:13 bcik go-librespot[14466]: time="2026-02-25T19:21:13+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" Feb 25 19:21:13 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:13 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:14 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:14 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:16 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 331. Feb 25 19:21:16 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:16 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:16 bcik go-librespot[14486]: go-librespot daemon starting... Feb 25 19:21:16 bcik go-librespot[14487]: time="2026-02-25T19:21:16+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:16 bcik go-librespot[14487]: time="2026-02-25T19:21:16+01:00" level=debug msg="app state loaded" Feb 25 19:21:16 bcik go-librespot[14487]: time="2026-02-25T19:21:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:16 bcik go-librespot[14487]: time="2026-02-25T19:21: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" Feb 25 19:21:16 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:16 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:17 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:17 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:19 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 332. Feb 25 19:21:19 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:19 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:19 bcik go-librespot[14493]: go-librespot daemon starting... Feb 25 19:21:19 bcik go-librespot[14494]: time="2026-02-25T19:21:19+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:19 bcik go-librespot[14494]: time="2026-02-25T19:21:19+01:00" level=debug msg="app state loaded" Feb 25 19:21:19 bcik go-librespot[14494]: time="2026-02-25T19:21:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:19 bcik go-librespot[14494]: time="2026-02-25T19:21: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" Feb 25 19:21:19 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:19 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:20 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:20 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:23 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 333. Feb 25 19:21:23 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:23 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:23 bcik go-librespot[14500]: go-librespot daemon starting... Feb 25 19:21:23 bcik go-librespot[14501]: time="2026-02-25T19:21:23+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:23 bcik go-librespot[14501]: time="2026-02-25T19:21:23+01:00" level=debug msg="app state loaded" Feb 25 19:21:23 bcik go-librespot[14501]: time="2026-02-25T19:21:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:23 bcik go-librespot[14501]: time="2026-02-25T19:21:23+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" Feb 25 19:21:23 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:23 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:23 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:23 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:26 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 334. Feb 25 19:21:26 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:26 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:26 bcik go-librespot[14521]: go-librespot daemon starting... Feb 25 19:21:26 bcik go-librespot[14522]: time="2026-02-25T19:21:26+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:26 bcik go-librespot[14522]: time="2026-02-25T19:21:26+01:00" level=debug msg="app state loaded" Feb 25 19:21:26 bcik go-librespot[14522]: time="2026-02-25T19:21:26+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:26 bcik go-librespot[14522]: time="2026-02-25T19:21:26+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" Feb 25 19:21:26 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:26 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:26 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:26 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:29 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:29 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:29 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 335. Feb 25 19:21:29 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:29 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:29 bcik go-librespot[14528]: go-librespot daemon starting... Feb 25 19:21:29 bcik go-librespot[14529]: time="2026-02-25T19:21:29+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:29 bcik go-librespot[14529]: time="2026-02-25T19:21:29+01:00" level=debug msg="app state loaded" Feb 25 19:21:29 bcik go-librespot[14529]: time="2026-02-25T19:21:29+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:29 bcik go-librespot[14529]: time="2026-02-25T19:21: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" Feb 25 19:21:29 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:29 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:32 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:32 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:32 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 336. Feb 25 19:21:32 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:32 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:32 bcik go-librespot[14535]: go-librespot daemon starting... Feb 25 19:21:32 bcik go-librespot[14536]: time="2026-02-25T19:21:32+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:32 bcik go-librespot[14536]: time="2026-02-25T19:21:32+01:00" level=debug msg="app state loaded" Feb 25 19:21:32 bcik go-librespot[14536]: time="2026-02-25T19:21:32+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:32 bcik go-librespot[14536]: time="2026-02-25T19:21: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" Feb 25 19:21:32 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:32 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:35 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:35 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:36 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 337. Feb 25 19:21:36 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:36 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:36 bcik go-librespot[14556]: go-librespot daemon starting... Feb 25 19:21:36 bcik go-librespot[14557]: time="2026-02-25T19:21:36+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:36 bcik go-librespot[14557]: time="2026-02-25T19:21:36+01:00" level=debug msg="app state loaded" Feb 25 19:21:36 bcik go-librespot[14557]: time="2026-02-25T19:21:36+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:36 bcik go-librespot[14557]: time="2026-02-25T19:21:36+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" Feb 25 19:21:36 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:36 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:38 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:38 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:39 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 338. Feb 25 19:21:39 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:39 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:39 bcik go-librespot[14563]: go-librespot daemon starting... Feb 25 19:21:39 bcik go-librespot[14564]: time="2026-02-25T19:21:39+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:39 bcik go-librespot[14564]: time="2026-02-25T19:21:39+01:00" level=debug msg="app state loaded" Feb 25 19:21:39 bcik go-librespot[14564]: time="2026-02-25T19:21:39+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:39 bcik go-librespot[14564]: time="2026-02-25T19:21:39+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" Feb 25 19:21:39 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:39 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:41 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:41 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:42 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 339. Feb 25 19:21:42 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:42 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:42 bcik go-librespot[14570]: go-librespot daemon starting... Feb 25 19:21:42 bcik go-librespot[14571]: time="2026-02-25T19:21:42+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:42 bcik go-librespot[14571]: time="2026-02-25T19:21:42+01:00" level=debug msg="app state loaded" Feb 25 19:21:42 bcik go-librespot[14571]: time="2026-02-25T19:21:42+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:42 bcik go-librespot[14571]: time="2026-02-25T19:21: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" Feb 25 19:21:42 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:42 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:44 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:44 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:45 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 340. Feb 25 19:21:45 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:45 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:45 bcik go-librespot[14591]: go-librespot daemon starting... Feb 25 19:21:45 bcik go-librespot[14592]: time="2026-02-25T19:21:45+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:45 bcik go-librespot[14592]: time="2026-02-25T19:21:45+01:00" level=debug msg="app state loaded" Feb 25 19:21:45 bcik go-librespot[14592]: time="2026-02-25T19:21:45+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:45 bcik go-librespot[14592]: time="2026-02-25T19:21: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" Feb 25 19:21:45 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:45 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:47 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:47 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:49 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 341. Feb 25 19:21:49 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:49 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:49 bcik go-librespot[14598]: go-librespot daemon starting... Feb 25 19:21:49 bcik go-librespot[14599]: time="2026-02-25T19:21:49+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:49 bcik go-librespot[14599]: time="2026-02-25T19:21:49+01:00" level=debug msg="app state loaded" Feb 25 19:21:49 bcik go-librespot[14599]: time="2026-02-25T19:21:49+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:49 bcik go-librespot[14599]: time="2026-02-25T19:21:49+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" Feb 25 19:21:49 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:49 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:50 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:50 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:52 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 342. Feb 25 19:21:52 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:52 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:52 bcik go-librespot[14605]: go-librespot daemon starting... Feb 25 19:21:52 bcik go-librespot[14606]: time="2026-02-25T19:21:52+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:52 bcik go-librespot[14606]: time="2026-02-25T19:21:52+01:00" level=debug msg="app state loaded" Feb 25 19:21:52 bcik go-librespot[14606]: time="2026-02-25T19:21:52+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:52 bcik go-librespot[14606]: time="2026-02-25T19:21:52+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" Feb 25 19:21:52 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:52 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:53 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:53 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:55 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 343. Feb 25 19:21:55 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:55 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:55 bcik go-librespot[14612]: go-librespot daemon starting... Feb 25 19:21:55 bcik go-librespot[14613]: time="2026-02-25T19:21:55+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:55 bcik go-librespot[14613]: time="2026-02-25T19:21:55+01:00" level=debug msg="app state loaded" Feb 25 19:21:55 bcik go-librespot[14613]: time="2026-02-25T19:21:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:55 bcik go-librespot[14613]: time="2026-02-25T19:21:55+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" Feb 25 19:21:55 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:55 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:56 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:56 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:21:58 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 344. Feb 25 19:21:58 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:58 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:21:58 bcik go-librespot[14634]: go-librespot daemon starting... Feb 25 19:21:58 bcik go-librespot[14635]: time="2026-02-25T19:21:58+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:21:58 bcik go-librespot[14635]: time="2026-02-25T19:21:58+01:00" level=debug msg="app state loaded" Feb 25 19:21:58 bcik go-librespot[14635]: time="2026-02-25T19:21:58+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:21:58 bcik go-librespot[14635]: time="2026-02-25T19:21:58+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" Feb 25 19:21:58 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:21:58 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:21:59 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:21:59 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:02 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 345. Feb 25 19:22:02 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:02 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:02 bcik go-librespot[14641]: go-librespot daemon starting... Feb 25 19:22:02 bcik go-librespot[14642]: time="2026-02-25T19:22:02+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:02 bcik go-librespot[14642]: time="2026-02-25T19:22:02+01:00" level=debug msg="app state loaded" Feb 25 19:22:02 bcik go-librespot[14642]: time="2026-02-25T19:22:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:02 bcik go-librespot[14642]: time="2026-02-25T19:22:02+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" Feb 25 19:22:02 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:02 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:02 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:02 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:05 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 346. Feb 25 19:22:05 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:05 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:05 bcik go-librespot[14648]: go-librespot daemon starting... Feb 25 19:22:05 bcik go-librespot[14649]: time="2026-02-25T19:22:05+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:05 bcik go-librespot[14649]: time="2026-02-25T19:22:05+01:00" level=debug msg="app state loaded" Feb 25 19:22:05 bcik go-librespot[14649]: time="2026-02-25T19:22:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:05 bcik go-librespot[14649]: time="2026-02-25T19:22:05+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" Feb 25 19:22:05 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:05 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:05 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:05 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:08 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:08 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:08 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 347. Feb 25 19:22:08 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:08 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:08 bcik go-librespot[14669]: go-librespot daemon starting... Feb 25 19:22:08 bcik go-librespot[14670]: time="2026-02-25T19:22:08+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:08 bcik go-librespot[14670]: time="2026-02-25T19:22:08+01:00" level=debug msg="app state loaded" Feb 25 19:22:08 bcik go-librespot[14670]: time="2026-02-25T19:22:08+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:08 bcik go-librespot[14670]: time="2026-02-25T19:22:08+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" Feb 25 19:22:08 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:08 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:08 bcik dhcpcd[1041]: eth0: carrier acquired Feb 25 19:22:08 bcik kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx Feb 25 19:22:08 bcik dhcpcd[1041]: eth0: IAID 9e:66:7e:89 Feb 25 19:22:08 bcik ifplugd(eth0)[1183]: Link beat detected. Feb 25 19:22:08 bcik ifplugd(eth0)[1183]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Feb 25 19:22:08 bcik ifplugd(eth0)[1183]: client: sending commands to dhcpcd process Feb 25 19:22:08 bcik dhcpcd[1041]: control command: dhcpcd eth0 Feb 25 19:22:08 bcik dhcpcd[1041]: control_free: No such file or directory Feb 25 19:22:09 bcik dhcpcd[1041]: eth0: soliciting an IPv6 router Feb 25 19:22:09 bcik ifplugd(eth0)[1183]: Program executed successfully. Feb 25 19:22:09 bcik volumio[1276]: info: Received Get System Info Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:22:09 bcik volumio[1276]: info: Discovery: Getting this device information Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::volumioGetState Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 19:22:09 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: === SNM TRANSITION === Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: New ethernet state: connected Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: Single Network Mode: enabled Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: First start: no Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: === END TRANSITION === Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Feb 25 19:22:09 bcik sudo[14735]: root : unable to resolve host bcik: System error Feb 25 19:22:09 bcik sudo[14735]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Feb 25 19:22:09 bcik sudo[14735]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 25 19:22:09 bcik dhcpcd[14736]: dhcpcd not running Feb 25 19:22:09 bcik sudo[14735]: pam_unix(sudo:session): session closed for user root Feb 25 19:22:09 bcik wireless.js[1019]: sudo: unable to resolve host bcik: System error Feb 25 19:22:09 bcik wireless.js[1019]: dhcpcd not running Feb 25 19:22:09 bcik wireless.js[1019]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Feb 25 19:22:10 bcik sudo[14745]: root : unable to resolve host bcik: System error Feb 25 19:22:10 bcik sudo[14745]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Feb 25 19:22:10 bcik sudo[14745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 25 19:22:10 bcik sudo[14745]: pam_unix(sudo:session): session closed for user root Feb 25 19:22:10 bcik sudo[14747]: root : unable to resolve host bcik: System error Feb 25 19:22:10 bcik sudo[14747]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Feb 25 19:22:10 bcik sudo[14747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 25 19:22:10 bcik sudo[14747]: pam_unix(sudo:session): session closed for user root Feb 25 19:22:10 bcik wireless.js[1019]: WIRELESS.JS - INFO: Cleaning previous... Feb 25 19:22:10 bcik dhcpcd[1041]: eth0: rebinding lease of 192.168.10.236 Feb 25 19:22:11 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:11 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:11 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 348. Feb 25 19:22:11 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:11 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:11 bcik go-librespot[14751]: go-librespot daemon starting... Feb 25 19:22:11 bcik go-librespot[14752]: time="2026-02-25T19:22:11+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:11 bcik go-librespot[14752]: time="2026-02-25T19:22:11+01:00" level=debug msg="app state loaded" Feb 25 19:22:11 bcik go-librespot[14752]: time="2026-02-25T19:22:11+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:11 bcik go-librespot[14752]: time="2026-02-25T19:22:11+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" Feb 25 19:22:11 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:11 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:12 bcik dhcpcd[1041]: eth0: carrier lost Feb 25 19:22:12 bcik kernel: macb 1f00100000.ethernet eth0: Link is Down Feb 25 19:22:13 bcik ifplugd(eth0)[1183]: Link beat lost. Feb 25 19:22:13 bcik volumio[1276]: info: Received Get System Info Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:22:13 bcik volumio[1276]: info: Discovery: Getting this device information Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::volumioGetState Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 19:22:13 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 19:22:14 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:14 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:15 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 349. Feb 25 19:22:15 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:15 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:15 bcik go-librespot[14773]: go-librespot daemon starting... Feb 25 19:22:15 bcik go-librespot[14774]: time="2026-02-25T19:22:15+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:15 bcik go-librespot[14774]: time="2026-02-25T19:22:15+01:00" level=debug msg="app state loaded" Feb 25 19:22:15 bcik go-librespot[14774]: time="2026-02-25T19:22:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:15 bcik go-librespot[14774]: time="2026-02-25T19:22:15+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" Feb 25 19:22:15 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:15 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:15 bcik dhcpcd[1041]: eth0: carrier acquired Feb 25 19:22:15 bcik kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx Feb 25 19:22:15 bcik dhcpcd[1041]: eth0: IAID 9e:66:7e:89 Feb 25 19:22:16 bcik dhcpcd[1041]: eth0: soliciting an IPv6 router Feb 25 19:22:16 bcik ifplugd(eth0)[1183]: Link beat detected. Feb 25 19:22:16 bcik dhcpcd[1041]: eth0: rebinding lease of 192.168.10.236 Feb 25 19:22:16 bcik volumio[1276]: info: Received Get System Info Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:22:16 bcik volumio[1276]: info: Discovery: Getting this device information Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::volumioGetState Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 19:22:16 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 19:22:17 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:17 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:18 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 350. Feb 25 19:22:18 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:18 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:18 bcik go-librespot[14797]: go-librespot daemon starting... Feb 25 19:22:18 bcik go-librespot[14798]: time="2026-02-25T19:22:18+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:18 bcik go-librespot[14798]: time="2026-02-25T19:22:18+01:00" level=debug msg="app state loaded" Feb 25 19:22:18 bcik go-librespot[14798]: time="2026-02-25T19:22:18+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:18 bcik go-librespot[14798]: time="2026-02-25T19:22:18+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" Feb 25 19:22:18 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:18 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:20 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:20 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:21 bcik dhcpcd[1041]: eth0: probing for an IPv4LL address Feb 25 19:22:21 bcik dhcpcd[1041]: eth0: DHCP lease expired Feb 25 19:22:21 bcik dhcpcd[1041]: eth0: soliciting a DHCP lease Feb 25 19:22:21 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 351. Feb 25 19:22:21 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:21 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:21 bcik go-librespot[14813]: go-librespot daemon starting... Feb 25 19:22:21 bcik go-librespot[14814]: time="2026-02-25T19:22:21+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:21 bcik go-librespot[14814]: time="2026-02-25T19:22:21+01:00" level=debug msg="app state loaded" Feb 25 19:22:21 bcik go-librespot[14814]: time="2026-02-25T19:22:21+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:21 bcik go-librespot[14814]: time="2026-02-25T19:22:21+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" Feb 25 19:22:21 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:21 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:23 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:23 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:24 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 352. Feb 25 19:22:24 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:24 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:24 bcik go-librespot[14821]: go-librespot daemon starting... Feb 25 19:22:24 bcik go-librespot[14822]: time="2026-02-25T19:22:24+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:24 bcik go-librespot[14822]: time="2026-02-25T19:22:24+01:00" level=debug msg="app state loaded" Feb 25 19:22:24 bcik go-librespot[14822]: time="2026-02-25T19:22:24+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:24 bcik go-librespot[14822]: time="2026-02-25T19:22:24+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" Feb 25 19:22:24 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:24 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:25 bcik dhcpcd[1041]: eth0: using IPv4LL address 169.254.72.239 Feb 25 19:22:25 bcik avahi-daemon[1004]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.72.239. Feb 25 19:22:25 bcik avahi-daemon[1004]: New relevant interface eth0.IPv4 for mDNS. Feb 25 19:22:25 bcik avahi-daemon[1004]: Registering new address record for 169.254.72.239 on eth0.IPv4. Feb 25 19:22:25 bcik dhcpcd[1041]: eth0: adding route to 169.254.0.0/16 Feb 25 19:22:25 bcik dhcpcd[1041]: eth0: adding default route Feb 25 19:22:25 bcik systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:25 bcik systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Feb 25 19:22:25 bcik systemd[1]: welcome.service: Deactivated successfully. Feb 25 19:22:25 bcik systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 25 19:22:25 bcik systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 25 19:22:25 bcik systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 25 19:22:25 bcik welcome[14851]: Resolved ip:[1] 169.254.72.239 Feb 25 19:22:25 bcik systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 25 19:22:25 bcik systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.102792, 0] ../../source3/nmbd/nmbd_nameregister.c:553(register_name) Feb 25 19:22:26 bcik nmbd[1244]: register_name: NetBIOS name BĄCIK cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.103304, 0] ../../source3/nmbd/nmbd_nameregister.c:553(register_name) Feb 25 19:22:26 bcik nmbd[1244]: register_name: NetBIOS name BĄCIK cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.103341, 0] ../../source3/nmbd/nmbd_nameregister.c:553(register_name) Feb 25 19:22:26 bcik nmbd[1244]: register_name: NetBIOS name BĄCIK cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.106262, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 25 19:22:26 bcik nmbd[1244]: register_name_response: Answer name <00> differs from question name <00>. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.106351, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 25 19:22:26 bcik nmbd[1244]: register_name_response: Answer name <03> differs from question name <03>. Feb 25 19:22:26 bcik nmbd[1244]: [2026/02/25 19:22:26.106411, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Feb 25 19:22:26 bcik nmbd[1244]: register_name_response: Answer name <20> differs from question name <20>. Feb 25 19:22:26 bcik volumio[1276]: info: Received Get System Info Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 19:22:26 bcik volumio[1276]: info: Discovery: Getting this device information Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::volumioGetState Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 19:22:26 bcik volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 19:22:26 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:26 bcik volumio[1276]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 25 19:22:27 bcik ntpd[1195]: IO: Listen normally on 4 eth0 169.254.72.239:123 Feb 25 19:22:27 bcik ntpd[1195]: IO: new interface(s) found: waking up resolver Feb 25 19:22:28 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 353. Feb 25 19:22:28 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:28 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:28 bcik go-librespot[14860]: go-librespot daemon starting... Feb 25 19:22:28 bcik go-librespot[14861]: time="2026-02-25T19:22:28+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:28 bcik go-librespot[14861]: time="2026-02-25T19:22:28+01:00" level=debug msg="app state loaded" Feb 25 19:22:28 bcik go-librespot[14861]: time="2026-02-25T19:22:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:29 bcik volumio[1276]: info: Initializing connection to go-librespot Websocket Feb 25 19:22:29 bcik volumio[1276]: info: Connection to go-librespot Websocket established Feb 25 19:22:29 bcik go-librespot[14861]: time="2026-02-25T19:22:29+01:00" level=debug msg="new websocket client" Feb 25 19:22:31 bcik dhcpcd[1041]: eth0: using IPv4LL address 169.254.72.239 Feb 25 19:22:32 bcik volumio[1276]: info: Getting Spotify volume Feb 25 19:22:32 bcik volumio[1276]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 25 19:22:32 bcik volumio[1276]: info: CoreCommandRouter::volumioGetState Feb 25 19:22:32 bcik volumio[1276]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Feb 25 19:22:35 bcik volumio[1276]: info: Volumio Network Manager: Network status updated: 1 Feb 25 19:22:38 bcik go-librespot[14861]: time="2026-02-25T19:22: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" Feb 25 19:22:38 bcik volumio[1276]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 19:22:38 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:38 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:38 bcik volumio[1276]: Error: socket hang up Feb 25 19:22:38 bcik volumio[1276]: at connResetException (node:internal/errors:720:14) Feb 25 19:22:38 bcik volumio[1276]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 25 19:22:38 bcik volumio[1276]: at Socket.emit (node:events:526:35) Feb 25 19:22:38 bcik volumio[1276]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 25 19:22:38 bcik volumio[1276]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 25 19:22:38 bcik volumio[1276]: code: 'ECONNRESET', Feb 25 19:22:38 bcik volumio[1276]: response: undefined Feb 25 19:22:38 bcik volumio[1276]: } Feb 25 19:22:38 bcik volumio[1276]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 19:22:41 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 354. Feb 25 19:22:41 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:41 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:41 bcik go-librespot[14905]: go-librespot daemon starting... Feb 25 19:22:41 bcik go-librespot[14906]: time="2026-02-25T19:22:41+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:41 bcik go-librespot[14906]: time="2026-02-25T19:22:41+01:00" level=debug msg="app state loaded" Feb 25 19:22:41 bcik go-librespot[14906]: time="2026-02-25T19:22:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:53 bcik dhcpcd[1041]: eth0: offered 192.168.10.236 from 192.168.10.1 Feb 25 19:22:53 bcik dhcpcd[1041]: eth0: probing address 192.168.10.236/24 Feb 25 19:22:53 bcik go-librespot[14906]: time="2026-02-25T19:22:53+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" Feb 25 19:22:53 bcik systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 25 19:22:53 bcik systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 25 19:22:56 bcik systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 355. Feb 25 19:22:56 bcik systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:56 bcik systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 25 19:22:56 bcik go-librespot[14940]: go-librespot daemon starting... Feb 25 19:22:56 bcik go-librespot[14941]: time="2026-02-25T19:22:56+01:00" level=info msg="running go-librespot 0.6.2" Feb 25 19:22:56 bcik go-librespot[14941]: time="2026-02-25T19:22:56+01:00" level=debug msg="app state loaded" Feb 25 19:22:56 bcik go-librespot[14941]: time="2026-02-25T19:22:56+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 25 19:22:57 bcik dhcpcd[1041]: eth0: leased 192.168.10.236 for 7200 seconds Feb 25 19:22:57 bcik avahi-daemon[1004]: Registering new address record for 192.168.10.236 on eth0.IPv4. Feb 25 19:22:57 bcik dhcpcd[1041]: eth0: adding route to 192.168.10.0/24 Feb 25 19:22:57 bcik dhcpcd[1041]: eth0: changing default route via 192.168.10.1 Feb 25 19:22:57 bcik systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:57 bcik systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Feb 25 19:22:57 bcik systemd[1]: welcome.service: Deactivated successfully. Feb 25 19:22:57 bcik systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 25 19:22:57 bcik systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 25 19:22:57 bcik dhcpcd[1041]: eth0: deleting route to 169.254.0.0/16 Feb 25 19:22:57 bcik avahi-daemon[1004]: Withdrawing address record for 169.254.72.239 on eth0. Feb 25 19:22:57 bcik avahi-daemon[1004]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.72.239. Feb 25 19:22:57 bcik avahi-daemon[1004]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.10.236. Feb 25 19:22:57 bcik systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 25 19:22:57 bcik welcome[14968]: Resolved ip:[1] 192.168.10.236 Feb 25 19:22:57 bcik systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 25 19:22:57 bcik systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:57 bcik systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:57 bcik systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Feb 25 19:22:57 bcik systemd[1]: welcome.service: Deactivated successfully. Feb 25 19:22:57 bcik systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 25 19:22:57 bcik systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 25 19:22:57 bcik systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 25 19:22:57 bcik welcome[14989]: Resolved ip:[1] 192.168.10.236 Feb 25 19:22:57 bcik systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 25 19:22:57 bcik systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Feb 25 19:22:58 bcik ntpd[1195]: IO: Listen normally on 5 eth0 192.168.10.236:123 Feb 25 19:22:58 bcik ntpd[1195]: IO: Deleting interface #4 eth0, 169.254.72.239#123, interface stats: received=0, sent=0, dropped=0, active_time=31 secs Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 109.206.205.233 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 178.215.228.24 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 194.92.94.32 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 194.146.251.102 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 212.127.78.21 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 85.115.212.254 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: PROTO: 162.159.200.1 unlink local addr 169.254.72.239 -> Feb 25 19:22:58 bcik ntpd[1195]: IO: new interface(s) found: waking up resolver Feb 25 19:23:01 bcik sudo[14904]: volumio : unable to resolve host bcik: System error Feb 25 19:23:01 bcik sudo[14904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 19:21' Feb 25 19:23:01 bcik sudo[14904]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"