Mar 25 00:16:00 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:00 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:01 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4047. Mar 25 00:16:01 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1509. Mar 25 00:16:01 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:01 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:01 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:01 w212-volumio go-librespot[4229]: go-librespot daemon starting... Mar 25 00:16:01 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:01 w212-volumio go-librespot[4230]: time="2026-03-25T00:16:01+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:01 w212-volumio go-librespot[4230]: time="2026-03-25T00:16:01+07:00" level=debug msg="app state loaded" Mar 25 00:16:01 w212-volumio go-librespot[4230]: time="2026-03-25T00:16:01+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:01 w212-volumio go-librespot[4230]: time="2026-03-25T00:16:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:01 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:01 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:01 w212-volumio upmpdcli[4231]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:16:01 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:01 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:16:03 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:03 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:04 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4048. Mar 25 00:16:04 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:04 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:04 w212-volumio go-librespot[4251]: go-librespot daemon starting... Mar 25 00:16:04 w212-volumio go-librespot[4252]: time="2026-03-25T00:16:04+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:04 w212-volumio go-librespot[4252]: time="2026-03-25T00:16:04+07:00" level=debug msg="app state loaded" Mar 25 00:16:04 w212-volumio go-librespot[4252]: time="2026-03-25T00:16:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:04 w212-volumio go-librespot[4252]: time="2026-03-25T00:16:04+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:04 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:04 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:06 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:06 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:07 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4049. Mar 25 00:16:07 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:07 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:07 w212-volumio go-librespot[4258]: go-librespot daemon starting... Mar 25 00:16:07 w212-volumio go-librespot[4259]: time="2026-03-25T00:16:07+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:07 w212-volumio go-librespot[4259]: time="2026-03-25T00:16:07+07:00" level=debug msg="app state loaded" Mar 25 00:16:07 w212-volumio go-librespot[4259]: time="2026-03-25T00:16:07+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:07 w212-volumio go-librespot[4259]: time="2026-03-25T00:16:07+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:07 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:07 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:09 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:09 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:11 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4050. Mar 25 00:16:11 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:11 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:11 w212-volumio go-librespot[4265]: go-librespot daemon starting... Mar 25 00:16:11 w212-volumio go-librespot[4266]: time="2026-03-25T00:16:11+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:11 w212-volumio go-librespot[4266]: time="2026-03-25T00:16:11+07:00" level=debug msg="app state loaded" Mar 25 00:16:11 w212-volumio go-librespot[4266]: time="2026-03-25T00:16:11+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:11 w212-volumio go-librespot[4266]: time="2026-03-25T00:16:11+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:11 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:11 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:12 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:12 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:14 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4051. Mar 25 00:16:14 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:14 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:14 w212-volumio go-librespot[4286]: go-librespot daemon starting... Mar 25 00:16:14 w212-volumio go-librespot[4287]: time="2026-03-25T00:16:14+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:14 w212-volumio go-librespot[4287]: time="2026-03-25T00:16:14+07:00" level=debug msg="app state loaded" Mar 25 00:16:14 w212-volumio go-librespot[4287]: time="2026-03-25T00:16:14+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:14 w212-volumio go-librespot[4287]: time="2026-03-25T00:16:14+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:14 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:14 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:15 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:15 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:16 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1510. Mar 25 00:16:16 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:16 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:16 w212-volumio upmpdcli[4293]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:16:16 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:16 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:16:17 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4052. Mar 25 00:16:17 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:17 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:17 w212-volumio go-librespot[4294]: go-librespot daemon starting... Mar 25 00:16:17 w212-volumio go-librespot[4295]: time="2026-03-25T00:16:17+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:17 w212-volumio go-librespot[4295]: time="2026-03-25T00:16:17+07:00" level=debug msg="app state loaded" Mar 25 00:16:17 w212-volumio go-librespot[4295]: time="2026-03-25T00:16:17+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:17 w212-volumio go-librespot[4295]: time="2026-03-25T00:16:17+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:17 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:17 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:18 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:18 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:20 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4053. Mar 25 00:16:20 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:20 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:20 w212-volumio go-librespot[4302]: go-librespot daemon starting... Mar 25 00:16:20 w212-volumio go-librespot[4303]: time="2026-03-25T00:16:20+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:20 w212-volumio go-librespot[4303]: time="2026-03-25T00:16:20+07:00" level=debug msg="app state loaded" Mar 25 00:16:20 w212-volumio go-librespot[4303]: time="2026-03-25T00:16:20+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:20 w212-volumio go-librespot[4303]: time="2026-03-25T00:16:20+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:20 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:20 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:21 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:21 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:24 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4054. Mar 25 00:16:24 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:24 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:24 w212-volumio go-librespot[4323]: go-librespot daemon starting... Mar 25 00:16:24 w212-volumio go-librespot[4324]: time="2026-03-25T00:16:24+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:24 w212-volumio go-librespot[4324]: time="2026-03-25T00:16:24+07:00" level=debug msg="app state loaded" Mar 25 00:16:24 w212-volumio go-librespot[4324]: time="2026-03-25T00:16:24+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:24 w212-volumio go-librespot[4324]: time="2026-03-25T00:16:24+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:24 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:24 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:24 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:24 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:27 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:27 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:27 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4055. Mar 25 00:16:27 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:27 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:27 w212-volumio go-librespot[4330]: go-librespot daemon starting... Mar 25 00:16:27 w212-volumio go-librespot[4331]: time="2026-03-25T00:16:27+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:27 w212-volumio go-librespot[4331]: time="2026-03-25T00:16:27+07:00" level=debug msg="app state loaded" Mar 25 00:16:27 w212-volumio go-librespot[4331]: time="2026-03-25T00:16:27+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:27 w212-volumio go-librespot[4331]: time="2026-03-25T00:16:27+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:27 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:27 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:30 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:30 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:30 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4056. Mar 25 00:16:30 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:30 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:30 w212-volumio go-librespot[4337]: go-librespot daemon starting... Mar 25 00:16:30 w212-volumio go-librespot[4338]: time="2026-03-25T00:16:30+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:30 w212-volumio go-librespot[4338]: time="2026-03-25T00:16:30+07:00" level=debug msg="app state loaded" Mar 25 00:16:30 w212-volumio go-librespot[4338]: time="2026-03-25T00:16:30+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:30 w212-volumio go-librespot[4338]: time="2026-03-25T00:16:30+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:30 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:30 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:31 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1511. Mar 25 00:16:31 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:31 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:31 w212-volumio upmpdcli[4344]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:16:31 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:31 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:16:33 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:33 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:33 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4057. Mar 25 00:16:33 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:33 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:33 w212-volumio go-librespot[4345]: go-librespot daemon starting... Mar 25 00:16:33 w212-volumio go-librespot[4346]: time="2026-03-25T00:16:33+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:33 w212-volumio go-librespot[4346]: time="2026-03-25T00:16:33+07:00" level=debug msg="app state loaded" Mar 25 00:16:33 w212-volumio go-librespot[4346]: time="2026-03-25T00:16:33+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:33 w212-volumio go-librespot[4346]: time="2026-03-25T00:16:33+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:33 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:33 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:36 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:36 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:37 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4058. Mar 25 00:16:37 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:37 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:37 w212-volumio go-librespot[4368]: go-librespot daemon starting... Mar 25 00:16:37 w212-volumio go-librespot[4369]: time="2026-03-25T00:16:37+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:37 w212-volumio go-librespot[4369]: time="2026-03-25T00:16:37+07:00" level=debug msg="app state loaded" Mar 25 00:16:37 w212-volumio go-librespot[4369]: time="2026-03-25T00:16:37+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:37 w212-volumio go-librespot[4369]: time="2026-03-25T00:16:37+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:37 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:37 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:37 w212-volumio dhcpcd[981]: eth0: carrier acquired Mar 25 00:16:37 w212-volumio kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control tx Mar 25 00:16:37 w212-volumio dhcpcd[981]: eth0: IAID 67:8f:cc:6d Mar 25 00:16:37 w212-volumio ifplugd(eth0)[1088]: Link beat detected. Mar 25 00:16:37 w212-volumio dhcpcd[981]: eth0: soliciting an IPv6 router Mar 25 00:16:37 w212-volumio ifplugd(eth0)[1088]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 25 00:16:37 w212-volumio ifplugd(eth0)[1088]: client: command failed: No such device (-19) Mar 25 00:16:37 w212-volumio ifplugd(eth0)[1088]: client: sending commands to dhcpcd process Mar 25 00:16:37 w212-volumio dhcpcd[981]: ps_ctl_dispatch: cannot handle another client Mar 25 00:16:37 w212-volumio dhcpcd[981]: control_free: No such file or directory Mar 25 00:16:37 w212-volumio volumio[1168]: info: Received Get System Info Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:16:37 w212-volumio volumio[1168]: info: Discovery: Getting this device information Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 25 00:16:37 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 25 00:16:38 w212-volumio ifplugd(eth0)[1088]: Program executed successfully. Mar 25 00:16:39 w212-volumio dhcpcd[981]: eth0: rebinding lease of 192.168.8.3 Mar 25 00:16:39 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:39 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:40 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4059. Mar 25 00:16:40 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:40 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:40 w212-volumio go-librespot[4431]: go-librespot daemon starting... Mar 25 00:16:40 w212-volumio go-librespot[4432]: time="2026-03-25T00:16:40+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:40 w212-volumio go-librespot[4432]: time="2026-03-25T00:16:40+07:00" level=debug msg="app state loaded" Mar 25 00:16:40 w212-volumio go-librespot[4432]: time="2026-03-25T00:16:40+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:40 w212-volumio go-librespot[4432]: time="2026-03-25T00:16:40+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:40 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:40 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:42 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:42 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:43 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4060. Mar 25 00:16:43 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:43 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:43 w212-volumio go-librespot[4442]: go-librespot daemon starting... Mar 25 00:16:43 w212-volumio go-librespot[4443]: time="2026-03-25T00:16:43+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:43 w212-volumio go-librespot[4443]: time="2026-03-25T00:16:43+07:00" level=debug msg="app state loaded" Mar 25 00:16:43 w212-volumio go-librespot[4443]: time="2026-03-25T00:16:43+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:43 w212-volumio go-librespot[4443]: time="2026-03-25T00:16:43+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:43 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:43 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:44 w212-volumio dhcpcd[981]: eth0: DHCP lease expired Mar 25 00:16:44 w212-volumio dhcpcd[981]: eth0: soliciting a DHCP lease Mar 25 00:16:45 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:45 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:46 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4061. Mar 25 00:16:46 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:46 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:46 w212-volumio go-librespot[4475]: go-librespot daemon starting... Mar 25 00:16:46 w212-volumio go-librespot[4476]: time="2026-03-25T00:16:46+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:46 w212-volumio go-librespot[4476]: time="2026-03-25T00:16:46+07:00" level=debug msg="app state loaded" Mar 25 00:16:46 w212-volumio go-librespot[4476]: time="2026-03-25T00:16:46+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:46 w212-volumio go-librespot[4476]: time="2026-03-25T00:16:46+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:46 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:46 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:47 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1512. Mar 25 00:16:47 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:47 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:16:47 w212-volumio upmpdcli[4482]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:16:47 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:47 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:16:48 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:48 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:50 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4062. Mar 25 00:16:50 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:50 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:50 w212-volumio go-librespot[4486]: go-librespot daemon starting... Mar 25 00:16:50 w212-volumio go-librespot[4487]: time="2026-03-25T00:16:50+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:50 w212-volumio go-librespot[4487]: time="2026-03-25T00:16:50+07:00" level=debug msg="app state loaded" Mar 25 00:16:50 w212-volumio go-librespot[4487]: time="2026-03-25T00:16:50+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:50 w212-volumio go-librespot[4487]: time="2026-03-25T00:16:50+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:50 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:50 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:51 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:51 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:53 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4063. Mar 25 00:16:53 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:53 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:53 w212-volumio go-librespot[4496]: go-librespot daemon starting... Mar 25 00:16:53 w212-volumio go-librespot[4497]: time="2026-03-25T00:16:53+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:53 w212-volumio go-librespot[4497]: time="2026-03-25T00:16:53+07:00" level=debug msg="app state loaded" Mar 25 00:16:53 w212-volumio go-librespot[4497]: time="2026-03-25T00:16:53+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:53 w212-volumio go-librespot[4497]: time="2026-03-25T00:16:53+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:53 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:53 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:54 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:54 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:56 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4064. Mar 25 00:16:56 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:56 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:56 w212-volumio go-librespot[4520]: go-librespot daemon starting... Mar 25 00:16:56 w212-volumio go-librespot[4521]: time="2026-03-25T00:16:56+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:56 w212-volumio go-librespot[4521]: time="2026-03-25T00:16:56+07:00" level=debug msg="app state loaded" Mar 25 00:16:56 w212-volumio go-librespot[4521]: time="2026-03-25T00:16:56+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:56 w212-volumio go-librespot[4521]: time="2026-03-25T00:16:56+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:56 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:56 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:16:56 w212-volumio volumio[1168]: info: Tunnel connection is inactive, restarting it Mar 25 00:16:56 w212-volumio volumio[1168]: info: Starting Tunnel 1 Mar 25 00:16:56 w212-volumio volumio[1168]: info: Starting Tunnel Connection Checker Mar 25 00:16:56 w212-volumio sudo[4535]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 25 00:16:56 w212-volumio sudo[4535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:16:56 w212-volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:56 w212-volumio sudo[4535]: pam_unix(sudo:session): session closed for user root Mar 25 00:16:56 w212-volumio volumio[1168]: info: Remote SSH Started Mar 25 00:16:56 w212-volumio autossh[4538]: port set to 0, monitoring disabled Mar 25 00:16:56 w212-volumio autossh[4538]: starting ssh (count 1) Mar 25 00:16:56 w212-volumio autossh[4538]: ssh child pid is 4541 Mar 25 00:16:56 w212-volumio volumio[1168]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 25 00:16:56 w212-volumio volumiossh-tunnel[4541]: ssh: Could not resolve hostname as1.myvolumio.org: Device or resource busy Mar 25 00:16:56 w212-volumio autossh[4538]: ssh exited prematurely with status 255; autossh exiting Mar 25 00:16:56 w212-volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:56 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:56 w212-volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 1. Mar 25 00:16:57 w212-volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio autossh[4543]: port set to 0, monitoring disabled Mar 25 00:16:57 w212-volumio autossh[4543]: starting ssh (count 1) Mar 25 00:16:57 w212-volumio autossh[4543]: ssh child pid is 4546 Mar 25 00:16:57 w212-volumio volumiossh-tunnel[4546]: ssh: Could not resolve hostname as1.myvolumio.org: Device or resource busy Mar 25 00:16:57 w212-volumio autossh[4543]: ssh exited prematurely with status 255; autossh exiting Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:57 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:16:57 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 2. Mar 25 00:16:57 w212-volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio autossh[4548]: port set to 0, monitoring disabled Mar 25 00:16:57 w212-volumio autossh[4548]: starting ssh (count 1) Mar 25 00:16:57 w212-volumio autossh[4548]: ssh child pid is 4551 Mar 25 00:16:57 w212-volumio volumiossh-tunnel[4551]: ssh: Could not resolve hostname as1.myvolumio.org: Device or resource busy Mar 25 00:16:57 w212-volumio autossh[4548]: ssh exited prematurely with status 255; autossh exiting Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 3. Mar 25 00:16:57 w212-volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio autossh[4554]: port set to 0, monitoring disabled Mar 25 00:16:57 w212-volumio autossh[4554]: starting ssh (count 1) Mar 25 00:16:57 w212-volumio autossh[4554]: ssh child pid is 4557 Mar 25 00:16:57 w212-volumio volumiossh-tunnel[4557]: ssh: Could not resolve hostname as1.myvolumio.org: Device or resource busy Mar 25 00:16:57 w212-volumio autossh[4554]: ssh exited prematurely with status 255; autossh exiting Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 4. Mar 25 00:16:57 w212-volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:57 w212-volumio autossh[4560]: port set to 0, monitoring disabled Mar 25 00:16:57 w212-volumio autossh[4560]: starting ssh (count 1) Mar 25 00:16:57 w212-volumio autossh[4560]: ssh child pid is 4563 Mar 25 00:16:57 w212-volumio volumiossh-tunnel[4563]: ssh: Could not resolve hostname as1.myvolumio.org: Device or resource busy Mar 25 00:16:57 w212-volumio autossh[4560]: ssh exited prematurely with status 255; autossh exiting Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:57 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:58 w212-volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 5. Mar 25 00:16:58 w212-volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:58 w212-volumio systemd[1]: sshtunnel.service: Start request repeated too quickly. Mar 25 00:16:58 w212-volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 25 00:16:58 w212-volumio systemd[1]: Failed to start sshtunnel.service - MyVolumio SSH Tunnel. Mar 25 00:16:59 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4065. Mar 25 00:16:59 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:59 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:16:59 w212-volumio go-librespot[4566]: go-librespot daemon starting... Mar 25 00:16:59 w212-volumio go-librespot[4567]: time="2026-03-25T00:16:59+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:16:59 w212-volumio go-librespot[4567]: time="2026-03-25T00:16:59+07:00" level=debug msg="app state loaded" Mar 25 00:16:59 w212-volumio go-librespot[4567]: time="2026-03-25T00:16:59+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:16:59 w212-volumio go-librespot[4567]: time="2026-03-25T00:16:59+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:16:59 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:16:59 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:00 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:00 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:02 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1513. Mar 25 00:17:02 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:17:02 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:17:02 w212-volumio upmpdcli[4576]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:17:02 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:02 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:17:03 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4066. Mar 25 00:17:03 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:03 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:03 w212-volumio go-librespot[4578]: go-librespot daemon starting... Mar 25 00:17:03 w212-volumio go-librespot[4579]: time="2026-03-25T00:17:03+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:17:03 w212-volumio go-librespot[4579]: time="2026-03-25T00:17:03+07:00" level=debug msg="app state loaded" Mar 25 00:17:03 w212-volumio go-librespot[4579]: time="2026-03-25T00:17:03+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:17:03 w212-volumio go-librespot[4579]: time="2026-03-25T00:17:03+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:17:03 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:03 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:03 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:03 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:06 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:06 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:06 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4067. Mar 25 00:17:06 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:06 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:06 w212-volumio go-librespot[4603]: go-librespot daemon starting... Mar 25 00:17:06 w212-volumio go-librespot[4604]: time="2026-03-25T00:17:06+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:17:06 w212-volumio go-librespot[4604]: time="2026-03-25T00:17:06+07:00" level=debug msg="app state loaded" Mar 25 00:17:06 w212-volumio go-librespot[4604]: time="2026-03-25T00:17:06+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:17:06 w212-volumio go-librespot[4604]: time="2026-03-25T00:17:06+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:17:06 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:06 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:09 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:09 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:09 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4068. Mar 25 00:17:09 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:09 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:09 w212-volumio go-librespot[4613]: go-librespot daemon starting... Mar 25 00:17:09 w212-volumio go-librespot[4614]: time="2026-03-25T00:17:09+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:17:09 w212-volumio go-librespot[4614]: time="2026-03-25T00:17:09+07:00" level=debug msg="app state loaded" Mar 25 00:17:09 w212-volumio go-librespot[4614]: time="2026-03-25T00:17:09+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:17:09 w212-volumio go-librespot[4614]: time="2026-03-25T00:17:09+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:17:09 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:09 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:10 w212-volumio dhcpcd[981]: eth0: offered 192.168.8.3 from 192.168.8.1 Mar 25 00:17:10 w212-volumio dhcpcd[981]: eth0: probing address 192.168.8.3/24 Mar 25 00:17:12 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:12 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:12 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4069. Mar 25 00:17:12 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:12 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:12 w212-volumio go-librespot[4625]: go-librespot daemon starting... Mar 25 00:17:12 w212-volumio go-librespot[4626]: time="2026-03-25T00:17:12+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:17:12 w212-volumio go-librespot[4626]: time="2026-03-25T00:17:12+07:00" level=debug msg="app state loaded" Mar 25 00:17:12 w212-volumio go-librespot[4626]: time="2026-03-25T00:17:12+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:17:12 w212-volumio go-librespot[4626]: time="2026-03-25T00:17:12+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 00:17:12 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:12 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:14 w212-volumio dhcpcd[981]: eth0: leased 192.168.8.3 for infinity Mar 25 00:17:14 w212-volumio avahi-daemon[934]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.8.3. Mar 25 00:17:14 w212-volumio avahi-daemon[934]: New relevant interface eth0.IPv4 for mDNS. Mar 25 00:17:14 w212-volumio avahi-daemon[934]: Registering new address record for 192.168.8.3 on eth0.IPv4. Mar 25 00:17:14 w212-volumio dhcpcd[981]: eth0: adding route to 192.168.8.0/24 Mar 25 00:17:14 w212-volumio dhcpcd[981]: eth0: adding default route via 192.168.8.1 Mar 25 00:17:14 w212-volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Mar 25 00:17:14 w212-volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Mar 25 00:17:14 w212-volumio systemd[1]: welcome.service: Deactivated successfully. Mar 25 00:17:14 w212-volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 25 00:17:14 w212-volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 25 00:17:14 w212-volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 25 00:17:14 w212-volumio welcome[4667]: Resolved ip:[1] 192.168.8.3 Mar 25 00:17:14 w212-volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 25 00:17:14 w212-volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 25 00:17:15 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:15 w212-volumio volumio[1168]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:15 w212-volumio volumio[1168]: info: Received Get System Info Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 25 00:17:15 w212-volumio volumio[1168]: info: Discovery: Getting this device information Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::volumioGetState Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 25 00:17:15 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 25 00:17:16 w212-volumio ntpd[1075]: IO: Listen normally on 6 eth0 192.168.8.3:123 Mar 25 00:17:16 w212-volumio ntpd[1075]: IO: new interface(s) found: waking up resolver Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: Pool taking: 116.12.47.30 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: Pool taking: 103.169.192.229 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: Pool skipping: 27.54.117.72 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: Pool taking: 103.75.96.206 Mar 25 00:17:16 w212-volumio ntpd[1075]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Mar 25 00:17:16 w212-volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4070. Mar 25 00:17:16 w212-volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:16 w212-volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 00:17:16 w212-volumio go-librespot[4676]: go-librespot daemon starting... Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=info msg="running go-librespot 0.7.1" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=debug msg="app state loaded" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 00:17:16 w212-volumio volumio[1168]: info: Mar 25 00:17:16 w212-volumio volumio[1168]: ---------------------------- Client requests Volumio play Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreCommandRouter::volumioPlay Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::play index undefined Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 25 00:17:16 w212-volumio volumio[1168]: info: CorePlayQueue::getTrack 11 Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::startPlaybackTimer Mar 25 00:17:16 w212-volumio volumio[1168]: info: CorePlayQueue::getTrack 11 Mar 25 00:17:16 w212-volumio volumio[1168]: info: [1774372636288] ControllerTidal::resume Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 25 00:17:16 w212-volumio volumio[1168]: info: ControllerMpd::resume Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand play Mar 25 00:17:16 w212-volumio volumio[1168]: info: sendMpdCommand play took 11 milliseconds Mar 25 00:17:16 w212-volumio volumio[1168]: info: Mar 25 00:17:16 w212-volumio volumio[1168]: ---------------------------- MPD announces state update: player Mar 25 00:17:16 w212-volumio volumio[1168]: info: ControllerMpd::getState Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand status Mar 25 00:17:16 w212-volumio volumio[1168]: info: sendMpdCommand status took 0 milliseconds Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: ControllerMpd::parseState Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 25 00:17:16 w212-volumio volumio[1168]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: ControllerMpd::parseTrackInfo Mar 25 00:17:16 w212-volumio volumio[1168]: info: ControllerMpd::pushState Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreCommandRouter::servicePushState Mar 25 00:17:16 w212-volumio volumio[1168]: info: CorePlayQueue::getTrack 11 Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133722,"duration":359,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1019 Kbps","isStreaming":false,"title":"0.flac?token=1774365428~NGFlNzczMWNiMDEwNDlmN2U5ODg4Zjk2YmIwNDM2NjYzZGRmZDExZA==","artist":null,"album":null,"uri":"http://lgf.audio.tidal.com/mediatracks/CAEaKwgDEidhMjZlMTIxZDY3YjYwNDZlNWYxZWYwN2MzNGZmZTc0Ml82MS5tcDQ/0.flac?token=1774365428~NGFlNzczMWNiMDEwNDlmN2U5ODg4Zjk2YmIwNDM2NjYzZGRmZDExZA==","trackType":"tidal"} Mar 25 00:17:16 w212-volumio volumio[1168]: verbose: CURRENT POSITION 11 Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::syncState stateService play Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::syncState currentStatus pause Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreStateMachine::pushState Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 25 00:17:16 w212-volumio volumio[1168]: info: CoreCommandRouter::volumioPushState Mar 25 00:17:16 w212-volumio volumio[1168]: info: ------------------------------ 5ms Mar 25 00:17:16 w212-volumio volumio[1168]: SPOTIFY: RECEIVED VOLUMIO VOLUME 40 Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=info msg="zeroconf server listening on port 39377" Mar 25 00:17:16 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:16+07:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 202.162.32.12 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 185.125.190.58 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 103.83.142.30 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 116.12.46.30 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 240b:400b:21:cc00:25e5:c8e2:87ae:9142 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 2603:1040:1801:8::14 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 240b:400b:1a:a002:ffff:4136:a295:9261 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: Pool taking: 240b:400b:21:cc00:25e5:c8e2:87ae:9141 Mar 25 00:17:17 w212-volumio ntpd[1075]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Mar 25 00:17:17 w212-volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1514. Mar 25 00:17:17 w212-volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:17:17 w212-volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 25 00:17:17 w212-volumio upmpdcli[4689]: Could not open config: /tmp/upmpdcli.conf Mar 25 00:17:17 w212-volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:17 w212-volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: Pool skipping: 119.110.74.102 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: Pool skipping: 27.54.117.72 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: Pool taking: 103.134.77.146 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: Pool skipping: 103.169.192.230 Mar 25 00:17:18 w212-volumio ntpd[1075]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Mar 25 00:17:18 w212-volumio volumio[1168]: info: Initializing connection to go-librespot Websocket Mar 25 00:17:18 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:18+07:00" level=debug msg="new websocket client" Mar 25 00:17:18 w212-volumio volumio[1168]: info: Connection to go-librespot Websocket established Mar 25 00:17:18 w212-volumio go-librespot[4677]: time="2026-03-25T00:17:18+07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: invalid status code from clienttoken: 503" Mar 25 00:17:18 w212-volumio volumio[1168]: info: Connection to go-librespot Websocket closed Mar 25 00:17:18 w212-volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 00:17:18 w212-volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 00:17:19 w212-volumio sudo[4692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:17:19 w212-volumio sudo[4692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:17:19 w212-volumio sudo[4692]: pam_unix(sudo:session): session closed for user root Mar 25 00:17:19 w212-volumio sudo[4694]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:17:19 w212-volumio sudo[4694]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:17:19 w212-volumio sudo[4694]: pam_unix(sudo:session): session closed for user root Mar 25 00:17:19 w212-volumio volumio[1168]: verbose: New Socket.io Connection to 192.168.8.3 from 192.168.8.108 UA: Mozilla/5.0 (Linux; Android 12; benz_hy1280x480 Build/PPR1.180610.011; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/66.0.3359.158 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Mar 25 00:17:20 w212-volumio volumio[1168]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 25 00:17:21 w212-volumio sudo[4700]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 25 00:17:21 w212-volumio sudo[4700]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:17:21 w212-volumio sudo[4700]: pam_unix(sudo:session): session closed for user root Mar 25 00:17:21 w212-volumio sudo[4702]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 25 00:17:21 w212-volumio sudo[4702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 25 00:17:21 w212-volumio sudo[4702]: pam_unix(sudo:session): session closed for user root Mar 25 00:17:21 w212-volumio volumio[1168]: info: Getting Spotify volume Mar 25 00:17:21 w212-volumio volumio[1168]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 00:17:21 w212-volumio volumio[1168]: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 00:17:21 w212-volumio volumio[1168]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Mar 25 00:17:21 w212-volumio volumio[1168]: errno: -111, Mar 25 00:17:21 w212-volumio volumio[1168]: code: 'ECONNREFUSED', Mar 25 00:17:21 w212-volumio volumio[1168]: syscall: 'connect', Mar 25 00:17:21 w212-volumio volumio[1168]: address: '127.0.0.1', Mar 25 00:17:21 w212-volumio volumio[1168]: port: 9879, Mar 25 00:17:21 w212-volumio volumio[1168]: response: undefined Mar 25 00:17:21 w212-volumio volumio[1168]: } Mar 25 00:17:21 w212-volumio volumio[1168]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 00:17:21 w212-volumio sudo[4721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 00:16' Mar 25 00:17:21 w212-volumio sudo[4721]: 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"