Feb 25 09:08:02 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 754.
Feb 25 09:08:02 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:02 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:02 the-oc go-librespot[14941]: go-librespot daemon starting...
Feb 25 09:08:02 the-oc go-librespot[14942]: time="2026-02-25T09:08:02Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:02 the-oc go-librespot[14942]: time="2026-02-25T09:08:02Z" level=debug msg="app state loaded"
Feb 25 09:08:02 the-oc go-librespot[14942]: time="2026-02-25T09:08:02Z" level=debug msg="stored credentials not found"
Feb 25 09:08:02 the-oc go-librespot[14942]: time="2026-02-25T09:08:02Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:02 the-oc go-librespot[14942]: time="2026-02-25T09:08:02Z" level=fatal msg="failed running zeroconf" 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 09:08:02 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:02 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:02 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:02 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:05 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:05 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:05 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 755.
Feb 25 09:08:05 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:05 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:05 the-oc go-librespot[14967]: go-librespot daemon starting...
Feb 25 09:08:05 the-oc go-librespot[14968]: time="2026-02-25T09:08:05Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:05 the-oc go-librespot[14968]: time="2026-02-25T09:08:05Z" level=debug msg="app state loaded"
Feb 25 09:08:05 the-oc go-librespot[14968]: time="2026-02-25T09:08:05Z" level=debug msg="stored credentials not found"
Feb 25 09:08:05 the-oc go-librespot[14968]: time="2026-02-25T09:08:05Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:05 the-oc go-librespot[14968]: time="2026-02-25T09:08:05Z" level=fatal msg="failed running zeroconf" 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 09:08:05 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:05 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:08 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:08 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:09 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 756.
Feb 25 09:08:09 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:09 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:09 the-oc go-librespot[14980]: go-librespot daemon starting...
Feb 25 09:08:09 the-oc go-librespot[14981]: time="2026-02-25T09:08:09Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:09 the-oc go-librespot[14981]: time="2026-02-25T09:08:09Z" level=debug msg="app state loaded"
Feb 25 09:08:09 the-oc go-librespot[14981]: time="2026-02-25T09:08:09Z" level=debug msg="stored credentials not found"
Feb 25 09:08:09 the-oc go-librespot[14981]: time="2026-02-25T09:08:09Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:09 the-oc go-librespot[14981]: time="2026-02-25T09:08:09Z" level=fatal msg="failed running zeroconf" 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 09:08:09 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:09 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:11 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:11 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:12 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 757.
Feb 25 09:08:12 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:12 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:12 the-oc go-librespot[14992]: go-librespot daemon starting...
Feb 25 09:08:12 the-oc go-librespot[14993]: time="2026-02-25T09:08:12Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:12 the-oc go-librespot[14993]: time="2026-02-25T09:08:12Z" level=debug msg="app state loaded"
Feb 25 09:08:12 the-oc go-librespot[14993]: time="2026-02-25T09:08:12Z" level=debug msg="stored credentials not found"
Feb 25 09:08:12 the-oc go-librespot[14993]: time="2026-02-25T09:08:12Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:12 the-oc go-librespot[14993]: time="2026-02-25T09:08:12Z" level=fatal msg="failed running zeroconf" 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 09:08:12 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:12 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:14 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:14 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:15 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 758.
Feb 25 09:08:15 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:15 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:15 the-oc go-librespot[15018]: go-librespot daemon starting...
Feb 25 09:08:15 the-oc go-librespot[15019]: time="2026-02-25T09:08:15Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:15 the-oc go-librespot[15019]: time="2026-02-25T09:08:15Z" level=debug msg="app state loaded"
Feb 25 09:08:15 the-oc go-librespot[15019]: time="2026-02-25T09:08:15Z" level=debug msg="stored credentials not found"
Feb 25 09:08:15 the-oc go-librespot[15019]: time="2026-02-25T09:08:15Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:15 the-oc go-librespot[15019]: time="2026-02-25T09:08:15Z" level=fatal msg="failed running zeroconf" 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 09:08:15 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:15 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:17 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:17 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:18 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 759.
Feb 25 09:08:18 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:18 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:18 the-oc go-librespot[15030]: go-librespot daemon starting...
Feb 25 09:08:18 the-oc go-librespot[15031]: time="2026-02-25T09:08:18Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:18 the-oc go-librespot[15031]: time="2026-02-25T09:08:18Z" level=debug msg="app state loaded"
Feb 25 09:08:18 the-oc go-librespot[15031]: time="2026-02-25T09:08:18Z" level=debug msg="stored credentials not found"
Feb 25 09:08:18 the-oc go-librespot[15031]: time="2026-02-25T09:08:18Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:18 the-oc go-librespot[15031]: time="2026-02-25T09:08:18Z" level=fatal msg="failed running zeroconf" 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 09:08:18 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:18 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:20 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:20 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:22 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 760.
Feb 25 09:08:22 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:22 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:22 the-oc go-librespot[15043]: go-librespot daemon starting...
Feb 25 09:08:22 the-oc go-librespot[15044]: time="2026-02-25T09:08:22Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:22 the-oc go-librespot[15044]: time="2026-02-25T09:08:22Z" level=debug msg="app state loaded"
Feb 25 09:08:22 the-oc go-librespot[15044]: time="2026-02-25T09:08:22Z" level=debug msg="stored credentials not found"
Feb 25 09:08:22 the-oc go-librespot[15044]: time="2026-02-25T09:08:22Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:22 the-oc go-librespot[15044]: time="2026-02-25T09:08:22Z" level=fatal msg="failed running zeroconf" 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 09:08:22 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:22 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:23 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:23 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:25 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 761.
Feb 25 09:08:25 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:25 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:25 the-oc go-librespot[15069]: go-librespot daemon starting...
Feb 25 09:08:25 the-oc go-librespot[15070]: time="2026-02-25T09:08:25Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:25 the-oc go-librespot[15070]: time="2026-02-25T09:08:25Z" level=debug msg="app state loaded"
Feb 25 09:08:25 the-oc go-librespot[15070]: time="2026-02-25T09:08:25Z" level=debug msg="stored credentials not found"
Feb 25 09:08:25 the-oc go-librespot[15070]: time="2026-02-25T09:08:25Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:25 the-oc go-librespot[15070]: time="2026-02-25T09:08:25Z" level=fatal msg="failed running zeroconf" 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 09:08:25 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:25 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:26 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:26 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:28 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 762.
Feb 25 09:08:28 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:28 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:28 the-oc go-librespot[15081]: go-librespot daemon starting...
Feb 25 09:08:28 the-oc go-librespot[15082]: time="2026-02-25T09:08:28Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:28 the-oc go-librespot[15082]: time="2026-02-25T09:08:28Z" level=debug msg="app state loaded"
Feb 25 09:08:28 the-oc go-librespot[15082]: time="2026-02-25T09:08:28Z" level=debug msg="stored credentials not found"
Feb 25 09:08:28 the-oc go-librespot[15082]: time="2026-02-25T09:08:28Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:28 the-oc go-librespot[15082]: time="2026-02-25T09:08:28Z" level=fatal msg="failed running zeroconf" 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 09:08:28 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:28 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:29 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:29 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:31 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 763.
Feb 25 09:08:31 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:31 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:31 the-oc go-librespot[15093]: go-librespot daemon starting...
Feb 25 09:08:31 the-oc go-librespot[15094]: time="2026-02-25T09:08:31Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:31 the-oc go-librespot[15094]: time="2026-02-25T09:08:31Z" level=debug msg="app state loaded"
Feb 25 09:08:31 the-oc go-librespot[15094]: time="2026-02-25T09:08:31Z" level=debug msg="stored credentials not found"
Feb 25 09:08:31 the-oc go-librespot[15094]: time="2026-02-25T09:08:31Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:31 the-oc go-librespot[15094]: time="2026-02-25T09:08:31Z" level=fatal msg="failed running zeroconf" 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 09:08:31 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:31 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:32 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:32 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:35 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 764.
Feb 25 09:08:35 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:35 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:35 the-oc go-librespot[15120]: go-librespot daemon starting...
Feb 25 09:08:35 the-oc go-librespot[15121]: time="2026-02-25T09:08:35Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:35 the-oc go-librespot[15121]: time="2026-02-25T09:08:35Z" level=debug msg="app state loaded"
Feb 25 09:08:35 the-oc go-librespot[15121]: time="2026-02-25T09:08:35Z" level=debug msg="stored credentials not found"
Feb 25 09:08:35 the-oc go-librespot[15121]: time="2026-02-25T09:08:35Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:35 the-oc go-librespot[15121]: time="2026-02-25T09:08:35Z" level=fatal msg="failed running zeroconf" 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 09:08:35 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:35 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:35 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:35 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:38 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 765.
Feb 25 09:08:38 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:38 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:38 the-oc go-librespot[15132]: go-librespot daemon starting...
Feb 25 09:08:38 the-oc go-librespot[15133]: time="2026-02-25T09:08:38Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:38 the-oc go-librespot[15133]: time="2026-02-25T09:08:38Z" level=debug msg="app state loaded"
Feb 25 09:08:38 the-oc go-librespot[15133]: time="2026-02-25T09:08:38Z" level=debug msg="stored credentials not found"
Feb 25 09:08:38 the-oc go-librespot[15133]: time="2026-02-25T09:08:38Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:38 the-oc go-librespot[15133]: time="2026-02-25T09:08:38Z" level=fatal msg="failed running zeroconf" 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 09:08:38 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:38 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:38 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:38 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:40 the-oc systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:40 the-oc systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 25 09:08:41 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 766.
Feb 25 09:08:41 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:41 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:41 the-oc go-librespot[15144]: go-librespot daemon starting...
Feb 25 09:08:41 the-oc go-librespot[15145]: time="2026-02-25T09:08:41Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:41 the-oc go-librespot[15145]: time="2026-02-25T09:08:41Z" level=debug msg="app state loaded"
Feb 25 09:08:41 the-oc go-librespot[15145]: time="2026-02-25T09:08:41Z" level=debug msg="stored credentials not found"
Feb 25 09:08:41 the-oc go-librespot[15145]: time="2026-02-25T09:08:41Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:41 the-oc go-librespot[15145]: time="2026-02-25T09:08:41Z" level=fatal msg="failed running zeroconf" 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 09:08:41 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:41 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:41 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:41 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:44 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:44 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:44 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 767.
Feb 25 09:08:44 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:44 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:44 the-oc go-librespot[15170]: go-librespot daemon starting...
Feb 25 09:08:44 the-oc go-librespot[15171]: time="2026-02-25T09:08:44Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:44 the-oc go-librespot[15171]: time="2026-02-25T09:08:44Z" level=debug msg="app state loaded"
Feb 25 09:08:44 the-oc go-librespot[15171]: time="2026-02-25T09:08:44Z" level=debug msg="stored credentials not found"
Feb 25 09:08:44 the-oc go-librespot[15171]: time="2026-02-25T09:08:44Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:44 the-oc go-librespot[15171]: time="2026-02-25T09:08:44Z" level=fatal msg="failed running zeroconf" 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 09:08:44 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:44 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:47 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:47 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:48 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 768.
Feb 25 09:08:48 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:48 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:48 the-oc go-librespot[15183]: go-librespot daemon starting...
Feb 25 09:08:48 the-oc go-librespot[15184]: time="2026-02-25T09:08:48Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:48 the-oc go-librespot[15184]: time="2026-02-25T09:08:48Z" level=debug msg="app state loaded"
Feb 25 09:08:48 the-oc go-librespot[15184]: time="2026-02-25T09:08:48Z" level=debug msg="stored credentials not found"
Feb 25 09:08:48 the-oc go-librespot[15184]: time="2026-02-25T09:08:48Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:48 the-oc go-librespot[15184]: time="2026-02-25T09:08:48Z" level=fatal msg="failed running zeroconf" 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 09:08:48 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:48 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:50 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:50 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:51 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 769.
Feb 25 09:08:51 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:51 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:51 the-oc go-librespot[15195]: go-librespot daemon starting...
Feb 25 09:08:51 the-oc go-librespot[15196]: time="2026-02-25T09:08:51Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:51 the-oc go-librespot[15196]: time="2026-02-25T09:08:51Z" level=debug msg="app state loaded"
Feb 25 09:08:51 the-oc go-librespot[15196]: time="2026-02-25T09:08:51Z" level=debug msg="stored credentials not found"
Feb 25 09:08:51 the-oc go-librespot[15196]: time="2026-02-25T09:08:51Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:51 the-oc go-librespot[15196]: time="2026-02-25T09:08:51Z" level=fatal msg="failed running zeroconf" 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 09:08:51 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:51 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:53 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:53 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:54 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 770.
Feb 25 09:08:54 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:54 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:54 the-oc go-librespot[15221]: go-librespot daemon starting...
Feb 25 09:08:54 the-oc go-librespot[15222]: time="2026-02-25T09:08:54Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:54 the-oc go-librespot[15222]: time="2026-02-25T09:08:54Z" level=debug msg="app state loaded"
Feb 25 09:08:54 the-oc go-librespot[15222]: time="2026-02-25T09:08:54Z" level=debug msg="stored credentials not found"
Feb 25 09:08:54 the-oc go-librespot[15222]: time="2026-02-25T09:08:54Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:54 the-oc go-librespot[15222]: time="2026-02-25T09:08:54Z" level=fatal msg="failed running zeroconf" 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 09:08:54 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:54 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:55 the-oc systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 35.
Feb 25 09:08:55 the-oc systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 25 09:08:55 the-oc systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 25 09:08:56 the-oc dhcpcd[863]: eth0: carrier acquired
Feb 25 09:08:56 the-oc kernel: r8169 0000:03:00.0 eth0: Link is Up - 1Gbps/Full - flow control off
Feb 25 09:08:56 the-oc dhcpcd[863]: eth0: IAID 20:08:a6:fc
Feb 25 09:08:56 the-oc dhcpcd[863]: eth0: soliciting an IPv6 router
Feb 25 09:08:56 the-oc volumio[1126]: info: Received Get System Info
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 09:08:56 the-oc volumio[1126]: info: Discovery: Getting this device information
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:08:56 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 09:08:56 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 09:08:56 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:56 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:08:56 the-oc ifplugd(eth0)[1058]: Link beat detected.
Feb 25 09:08:57 the-oc ifplugd(eth0)[1058]: Executing '/etc/ifplugd/ifplugd.action eth0 up'.
Feb 25 09:08:57 the-oc ifplugd(eth0)[1058]: client: command failed: No such device (-19)
Feb 25 09:08:57 the-oc ifplugd(eth0)[1058]: client: sending commands to dhcpcd process
Feb 25 09:08:57 the-oc dhcpcd[863]: control command: dhcpcd eth0
Feb 25 09:08:57 the-oc dhcpcd[863]: control_free: No such file or directory
Feb 25 09:08:57 the-oc ifplugd(eth0)[1058]: Program executed successfully.
Feb 25 09:08:57 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 771.
Feb 25 09:08:57 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:57 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:08:57 the-oc go-librespot[15292]: go-librespot daemon starting...
Feb 25 09:08:57 the-oc go-librespot[15293]: time="2026-02-25T09:08:57Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:08:57 the-oc go-librespot[15293]: time="2026-02-25T09:08:57Z" level=debug msg="app state loaded"
Feb 25 09:08:57 the-oc go-librespot[15293]: time="2026-02-25T09:08:57Z" level=debug msg="stored credentials not found"
Feb 25 09:08:57 the-oc go-librespot[15293]: time="2026-02-25T09:08:57Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:08:57 the-oc go-librespot[15293]: time="2026-02-25T09:08:57Z" level=fatal msg="failed running zeroconf" 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 09:08:57 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:08:57 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:08:58 the-oc dhcpcd[863]: eth0: rebinding lease of 192.168.1.112
Feb 25 09:08:59 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:08:59 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:01 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 772.
Feb 25 09:09:01 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:01 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:01 the-oc go-librespot[15306]: go-librespot daemon starting...
Feb 25 09:09:01 the-oc go-librespot[15307]: time="2026-02-25T09:09:01Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:01 the-oc go-librespot[15307]: time="2026-02-25T09:09:01Z" level=debug msg="app state loaded"
Feb 25 09:09:01 the-oc go-librespot[15307]: time="2026-02-25T09:09:01Z" level=debug msg="stored credentials not found"
Feb 25 09:09:01 the-oc go-librespot[15307]: time="2026-02-25T09:09:01Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:01 the-oc go-librespot[15307]: time="2026-02-25T09:09:01Z" level=fatal msg="failed running zeroconf" 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 09:09:01 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:01 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:02 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:02 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:03 the-oc dhcpcd[863]: eth0: probing for an IPv4LL address
Feb 25 09:09:03 the-oc dhcpcd[863]: eth0: DHCP lease expired
Feb 25 09:09:03 the-oc dhcpcd[863]: eth0: soliciting a DHCP lease
Feb 25 09:09:03 the-oc dhcpcd[863]: eth0: offered 192.168.1.112 from 192.168.1.254
Feb 25 09:09:03 the-oc dhcpcd[863]: eth0: probing address 192.168.1.112/24
Feb 25 09:09:04 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 773.
Feb 25 09:09:04 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:04 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:04 the-oc go-librespot[15329]: go-librespot daemon starting...
Feb 25 09:09:04 the-oc go-librespot[15338]: time="2026-02-25T09:09:04Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:04 the-oc go-librespot[15338]: time="2026-02-25T09:09:04Z" level=debug msg="app state loaded"
Feb 25 09:09:04 the-oc go-librespot[15338]: time="2026-02-25T09:09:04Z" level=debug msg="stored credentials not found"
Feb 25 09:09:04 the-oc go-librespot[15338]: time="2026-02-25T09:09:04Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:04 the-oc go-librespot[15338]: time="2026-02-25T09:09:04Z" level=fatal msg="failed running zeroconf" 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 09:09:04 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:04 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:05 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:05 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:07 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 774.
Feb 25 09:09:07 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:07 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:07 the-oc go-librespot[15355]: go-librespot daemon starting...
Feb 25 09:09:07 the-oc go-librespot[15356]: time="2026-02-25T09:09:07Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:07 the-oc go-librespot[15356]: time="2026-02-25T09:09:07Z" level=debug msg="app state loaded"
Feb 25 09:09:07 the-oc go-librespot[15356]: time="2026-02-25T09:09:07Z" level=debug msg="stored credentials not found"
Feb 25 09:09:07 the-oc go-librespot[15356]: time="2026-02-25T09:09:07Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:07 the-oc go-librespot[15356]: time="2026-02-25T09:09:07Z" level=fatal msg="failed running zeroconf" 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 09:09:07 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:07 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:08 the-oc dhcpcd[863]: eth0: leased 192.168.1.112 for 86400 seconds
Feb 25 09:09:08 the-oc avahi-daemon[783]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.112.
Feb 25 09:09:08 the-oc avahi-daemon[783]: New relevant interface eth0.IPv4 for mDNS.
Feb 25 09:09:08 the-oc avahi-daemon[783]: Registering new address record for 192.168.1.112 on eth0.IPv4.
Feb 25 09:09:08 the-oc dhcpcd[863]: eth0: adding route to 192.168.1.0/24
Feb 25 09:09:08 the-oc dhcpcd[863]: eth0: adding default route via 192.168.1.254
Feb 25 09:09:08 the-oc systemd[1]: welcome.service: Deactivated successfully.
Feb 25 09:09:08 the-oc systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 25 09:09:08 the-oc systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 25 09:09:08 the-oc systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 25 09:09:08 the-oc welcome[15379]: Resolved ip:[1] 192.168.1.112
Feb 25 09:09:08 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:08 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:08 the-oc systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 25 09:09:08 the-oc systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 25 09:09:09 the-oc volumio[1126]: info: Received Get System Info
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 09:09:09 the-oc volumio[1126]: info: Discovery: Getting this device information
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:09 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 09:09:09 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 09:09:10 the-oc ntpd[1020]: IO: Listen normally on 3 eth0 192.168.1.112:123
Feb 25 09:09:10 the-oc ntpd[1020]: IO: new interface(s) found: waking up resolver
Feb 25 09:09:10 the-oc ntpd[1020]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:10 the-oc dhcpcd[863]: eth0: carrier lost
Feb 25 09:09:10 the-oc kernel: r8169 0000:03:00.0 eth0: Link is Down
Feb 25 09:09:10 the-oc avahi-daemon[783]: Withdrawing address record for 192.168.1.112 on eth0.
Feb 25 09:09:10 the-oc avahi-daemon[783]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.112.
Feb 25 09:09:10 the-oc avahi-daemon[783]: Interface eth0.IPv4 no longer relevant for mDNS.
Feb 25 09:09:10 the-oc dhcpcd[863]: eth0: deleting route to 192.168.1.0/24
Feb 25 09:09:10 the-oc dhcpcd[863]: eth0: deleting default route via 192.168.1.254
Feb 25 09:09:10 the-oc volumio[1126]: info: Discovery: A device disappeared from network
Feb 25 09:09:10 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 775.
Feb 25 09:09:10 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:10 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:10 the-oc go-librespot[15420]: go-librespot daemon starting...
Feb 25 09:09:10 the-oc systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 25 09:09:10 the-oc systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 25 09:09:10 the-oc systemd[1]: welcome.service: Deactivated successfully.
Feb 25 09:09:10 the-oc systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 25 09:09:10 the-oc systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 25 09:09:10 the-oc systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 25 09:09:10 the-oc go-librespot[15422]: time="2026-02-25T09:09:10Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:10 the-oc go-librespot[15422]: time="2026-02-25T09:09:10Z" level=debug msg="app state loaded"
Feb 25 09:09:10 the-oc go-librespot[15422]: time="2026-02-25T09:09:10Z" level=debug msg="stored credentials not found"
Feb 25 09:09:10 the-oc welcome[15425]: Resolved ip:[0]
Feb 25 09:09:10 the-oc go-librespot[15422]: time="2026-02-25T09:09:10Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:10 the-oc go-librespot[15422]: time="2026-02-25T09:09:10Z" level=fatal msg="failed running zeroconf" 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 09:09:10 the-oc systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 25 09:09:10 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:10 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:10 the-oc systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 25 09:09:11 the-oc volumio[1126]: info: Received Get System Info
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 09:09:11 the-oc volumio[1126]: info: Discovery: Getting this device information
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:11 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 09:09:11 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 09:09:11 the-oc ifplugd(eth0)[1058]: Link beat lost.
Feb 25 09:09:11 the-oc systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:11 the-oc systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Feb 25 09:09:11 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:12 the-oc ntpd[1020]: IO: Deleting interface #3 eth0, 192.168.1.112#123, interface stats: received=0, sent=0, dropped=0, active_time=2 secs
Feb 25 09:09:13 the-oc dhcpcd[863]: eth0: carrier acquired
Feb 25 09:09:13 the-oc kernel: r8169 0000:03:00.0 eth0: Link is Up - 1Gbps/Full - flow control off
Feb 25 09:09:13 the-oc dhcpcd[863]: eth0: IAID 20:08:a6:fc
Feb 25 09:09:13 the-oc dhcpcd[863]: eth0: soliciting an IPv6 router
Feb 25 09:09:13 the-oc ifplugd(eth0)[1058]: Link beat detected.
Feb 25 09:09:13 the-oc dhcpcd[863]: eth0: rebinding lease of 192.168.1.112
Feb 25 09:09:13 the-oc volumio[1126]: info: Received Get System Info
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 09:09:13 the-oc volumio[1126]: info: Discovery: Getting this device information
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:13 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 09:09:13 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 09:09:13 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 776.
Feb 25 09:09:13 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:13 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:13 the-oc go-librespot[15442]: go-librespot daemon starting...
Feb 25 09:09:13 the-oc go-librespot[15443]: time="2026-02-25T09:09:13Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:13 the-oc go-librespot[15443]: time="2026-02-25T09:09:13Z" level=debug msg="app state loaded"
Feb 25 09:09:13 the-oc go-librespot[15443]: time="2026-02-25T09:09:13Z" level=debug msg="stored credentials not found"
Feb 25 09:09:13 the-oc go-librespot[15443]: time="2026-02-25T09:09:13Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:13 the-oc go-librespot[15443]: time="2026-02-25T09:09:13Z" level=fatal msg="failed running zeroconf" 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 09:09:13 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:13 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:14 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:14 the-oc volumio[1126]: info: Discovery: adding 588a23c9-aca0-41ff-b1c3-f5b289f5bbad
Feb 25 09:09:14 the-oc volumio[1126]: info: Discovery: Found device The OC
Feb 25 09:09:14 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:14 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:15 the-oc ntpd[1020]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
Feb 25 09:09:15 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:15 the-oc ntpd[1020]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12
Feb 25 09:09:16 the-oc ntpd[1020]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:16 the-oc ntpd[1020]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
Feb 25 09:09:16 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:16 the-oc ntpd[1020]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12
Feb 25 09:09:17 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 777.
Feb 25 09:09:17 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:17 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:17 the-oc go-librespot[15469]: go-librespot daemon starting...
Feb 25 09:09:17 the-oc go-librespot[15470]: time="2026-02-25T09:09:17Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:17 the-oc go-librespot[15470]: time="2026-02-25T09:09:17Z" level=debug msg="app state loaded"
Feb 25 09:09:17 the-oc go-librespot[15470]: time="2026-02-25T09:09:17Z" level=debug msg="stored credentials not found"
Feb 25 09:09:17 the-oc go-librespot[15470]: time="2026-02-25T09:09:17Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:17 the-oc go-librespot[15470]: time="2026-02-25T09:09:17Z" level=fatal msg="failed running zeroconf" 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 09:09:17 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:17 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:17 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:17 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:17 the-oc ntpd[1020]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:17 the-oc ntpd[1020]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
Feb 25 09:09:17 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:17 the-oc ntpd[1020]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12
Feb 25 09:09:18 the-oc dhcpcd[863]: eth0: probing for an IPv4LL address
Feb 25 09:09:18 the-oc dhcpcd[863]: eth0: DHCP lease expired
Feb 25 09:09:18 the-oc dhcpcd[863]: eth0: soliciting a DHCP lease
Feb 25 09:09:18 the-oc ntpd[1020]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:18 the-oc ntpd[1020]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
Feb 25 09:09:18 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:18 the-oc ntpd[1020]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12
Feb 25 09:09:20 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 778.
Feb 25 09:09:20 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:20 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:20 the-oc go-librespot[15494]: go-librespot daemon starting...
Feb 25 09:09:20 the-oc go-librespot[15495]: time="2026-02-25T09:09:20Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:20 the-oc go-librespot[15495]: time="2026-02-25T09:09:20Z" level=debug msg="app state loaded"
Feb 25 09:09:20 the-oc go-librespot[15495]: time="2026-02-25T09:09:20Z" level=debug msg="stored credentials not found"
Feb 25 09:09:20 the-oc go-librespot[15495]: time="2026-02-25T09:09:20Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:20 the-oc go-librespot[15495]: time="2026-02-25T09:09:20Z" level=fatal msg="failed running zeroconf" 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 09:09:20 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:20 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:20 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:20 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:23 the-oc dhcpcd[863]: eth0: probing for an IPv4LL address
Feb 25 09:09:23 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:23 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:23 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 779.
Feb 25 09:09:23 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:23 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:23 the-oc go-librespot[15507]: go-librespot daemon starting...
Feb 25 09:09:23 the-oc go-librespot[15508]: time="2026-02-25T09:09:23Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:23 the-oc go-librespot[15508]: time="2026-02-25T09:09:23Z" level=debug msg="app state loaded"
Feb 25 09:09:23 the-oc go-librespot[15508]: time="2026-02-25T09:09:23Z" level=debug msg="stored credentials not found"
Feb 25 09:09:23 the-oc go-librespot[15508]: time="2026-02-25T09:09:23Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:23 the-oc go-librespot[15508]: time="2026-02-25T09:09:23Z" level=fatal msg="failed running zeroconf" 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 09:09:23 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:23 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:26 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:26 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Feb 25 09:09:26 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 780.
Feb 25 09:09:26 the-oc systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 36.
Feb 25 09:09:26 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:26 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:26 the-oc systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 25 09:09:26 the-oc go-librespot[15532]: go-librespot daemon starting...
Feb 25 09:09:26 the-oc systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Feb 25 09:09:26 the-oc go-librespot[15533]: time="2026-02-25T09:09:26Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:26 the-oc go-librespot[15533]: time="2026-02-25T09:09:26Z" level=debug msg="app state loaded"
Feb 25 09:09:26 the-oc go-librespot[15533]: time="2026-02-25T09:09:26Z" level=debug msg="stored credentials not found"
Feb 25 09:09:26 the-oc go-librespot[15533]: time="2026-02-25T09:09:26Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:26 the-oc go-librespot[15533]: time="2026-02-25T09:09:26Z" level=fatal msg="failed running zeroconf" 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 09:09:26 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:26 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:28 the-oc dhcpcd[863]: eth0: using IPv4LL address 169.254.231.83
Feb 25 09:09:28 the-oc avahi-daemon[783]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.231.83.
Feb 25 09:09:28 the-oc avahi-daemon[783]: New relevant interface eth0.IPv4 for mDNS.
Feb 25 09:09:28 the-oc avahi-daemon[783]: Registering new address record for 169.254.231.83 on eth0.IPv4.
Feb 25 09:09:28 the-oc dhcpcd[863]: eth0: adding route to 169.254.0.0/16
Feb 25 09:09:28 the-oc dhcpcd[863]: eth0: adding default route
Feb 25 09:09:28 the-oc systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Feb 25 09:09:28 the-oc systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Feb 25 09:09:28 the-oc systemd[1]: welcome.service: Deactivated successfully.
Feb 25 09:09:28 the-oc systemd[1]: Stopped welcome.service - Show a welcome message on console.
Feb 25 09:09:28 the-oc systemd[1]: Stopping welcome.service - Show a welcome message on console...
Feb 25 09:09:28 the-oc systemd[1]: Starting welcome.service - Show a welcome message on console...
Feb 25 09:09:28 the-oc welcome[15560]: Resolved ip:[1] 169.254.231.83
Feb 25 09:09:28 the-oc systemd[1]: Finished welcome.service - Show a welcome message on console.
Feb 25 09:09:28 the-oc systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Feb 25 09:09:28 the-oc volumio[1126]: info: Received Get System Info
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 25 09:09:28 the-oc volumio[1126]: info: Discovery: Getting this device information
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:28 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 25 09:09:28 the-oc volumio[1126]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 25 09:09:29 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:29 the-oc ntpd[1020]: IO: Listen normally on 4 eth0 169.254.231.83:123
Feb 25 09:09:29 the-oc ntpd[1020]: IO: new interface(s) found: waking up resolver
Feb 25 09:09:29 the-oc ntpd[1020]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:30 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 781.
Feb 25 09:09:30 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:30 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:30 the-oc go-librespot[15568]: go-librespot daemon starting...
Feb 25 09:09:30 the-oc go-librespot[15569]: time="2026-02-25T09:09:30Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:30 the-oc go-librespot[15569]: time="2026-02-25T09:09:30Z" level=debug msg="app state loaded"
Feb 25 09:09:30 the-oc go-librespot[15569]: time="2026-02-25T09:09:30Z" level=debug msg="stored credentials not found"
Feb 25 09:09:30 the-oc go-librespot[15569]: time="2026-02-25T09:09:30Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:33 the-oc upmpdcli[15590]: writing RSA key
Feb 25 09:09:34 the-oc volumio[1126]: info: Volumio Network Manager: Network status updated: 1
Feb 25 09:09:35 the-oc ntpd[1020]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101
Feb 25 09:09:35 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:35 the-oc go-librespot[15569]: time="2026-02-25T09:09:35Z" level=fatal msg="failed running zeroconf" 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 09:09:35 the-oc ntpd[1020]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12
Feb 25 09:09:35 the-oc volumio[1126]: info: Error connecting to go-librespot Websocket: Error: read ECONNRESET
Feb 25 09:09:35 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:35 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:36 the-oc ntpd[1020]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:38 the-oc volumio[1126]: info: Initializing connection to go-librespot Websocket
Feb 25 09:09:39 the-oc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 782.
Feb 25 09:09:39 the-oc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:39 the-oc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Feb 25 09:09:39 the-oc go-librespot[15614]: go-librespot daemon starting...
Feb 25 09:09:39 the-oc go-librespot[15615]: time="2026-02-25T09:09:39Z" level=info msg="running go-librespot 0.6.2"
Feb 25 09:09:39 the-oc go-librespot[15615]: time="2026-02-25T09:09:39Z" level=debug msg="app state loaded"
Feb 25 09:09:39 the-oc go-librespot[15615]: time="2026-02-25T09:09:39Z" level=debug msg="stored credentials not found"
Feb 25 09:09:39 the-oc go-librespot[15615]: time="2026-02-25T09:09:39Z" level=info msg="api server listening on 127.0.0.1:9879"
Feb 25 09:09:45 the-oc ntpd[1020]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101
Feb 25 09:09:45 the-oc ntpd[1020]: DNS: dns_check: DNS error: -11, System error
Feb 25 09:09:45 the-oc volumio[1126]: info: Discovery: this is already registered, 588a23c9-aca0-41ff-b1c3-f5b289f5bbad
Feb 25 09:09:45 the-oc ntpd[1020]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12
Feb 25 09:09:45 the-oc volumio[1126]: info: Discovery: Found device The OC
Feb 25 09:09:45 the-oc volumio[1126]: info: CoreCommandRouter::volumioGetState
Feb 25 09:09:45 the-oc volumio[1126]: info: CorePlayQueue::getTrack 0
Feb 25 09:09:45 the-oc go-librespot[15615]: time="2026-02-25T09:09:45Z" level=debug msg="new websocket client"
Feb 25 09:09:45 the-oc volumio[1126]: info: Connection to go-librespot Websocket established
Feb 25 09:09:45 the-oc ntpd[1020]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101
Feb 25 09:09:46 the-oc dhcpcd[863]: eth0: offered 192.168.1.112 from 192.168.1.254
Feb 25 09:09:46 the-oc dhcpcd[863]: eth0: probing address 192.168.1.112/24
Feb 25 09:09:48 the-oc volumio[1126]: info: Getting Spotify volume
Feb 25 09:09:48 the-oc go-librespot[15615]: time="2026-02-25T09:09:48Z" level=fatal msg="failed running zeroconf" 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 09:09:48 the-oc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Feb 25 09:09:48 the-oc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Feb 25 09:09:48 the-oc volumio[1126]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 09:09:48 the-oc volumio[1126]: Error: socket hang up
Feb 25 09:09:48 the-oc volumio[1126]: at connResetException (node:internal/errors:720:14)
Feb 25 09:09:48 the-oc volumio[1126]: at Socket.socketOnEnd (node:_http_client:519:23)
Feb 25 09:09:48 the-oc volumio[1126]: at Socket.emit (node:events:526:35)
Feb 25 09:09:48 the-oc volumio[1126]: at endReadableNT (node:internal/streams/readable:1376:12)
Feb 25 09:09:48 the-oc volumio[1126]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
Feb 25 09:09:48 the-oc volumio[1126]: code: 'ECONNRESET',
Feb 25 09:09:48 the-oc volumio[1126]: response: undefined
Feb 25 09:09:48 the-oc volumio[1126]: }
Feb 25 09:09:48 the-oc volumio[1126]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 09:09:48 the-oc sudo[15662]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 09:08'
Feb 25 09:09:48 the-oc sudo[15662]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"