-- Logs begin at Sat 2025-06-21 13:05:05 CEST, end at Sat 2025-06-21 13:12:52 CEST. -- Jun 21 13:11:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:02 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:02 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:02 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:02 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Jun 21 13:11:02 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:02 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:02 volumio-mac-mini go-librespot[3740]: go-librespot daemon starting... Jun 21 13:11:02 volumio-mac-mini go-librespot[3740]: time="2025-06-21T13:11:02+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:02 volumio-mac-mini go-librespot[3740]: time="2025-06-21T13:11:02+02:00" level=debug msg="app state loaded" Jun 21 13:11:02 volumio-mac-mini go-librespot[3740]: time="2025-06-21T13:11:02+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:02 volumio-mac-mini go-librespot[3740]: time="2025-06-21T13:11:02+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:02 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:02 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:05 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:05 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:06 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:06 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Jun 21 13:11:06 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:06 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:06 volumio-mac-mini go-librespot[3747]: go-librespot daemon starting... Jun 21 13:11:06 volumio-mac-mini go-librespot[3747]: time="2025-06-21T13:11:06+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:06 volumio-mac-mini go-librespot[3747]: time="2025-06-21T13:11:06+02:00" level=debug msg="app state loaded" Jun 21 13:11:06 volumio-mac-mini go-librespot[3747]: time="2025-06-21T13:11:06+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:06 volumio-mac-mini go-librespot[3747]: time="2025-06-21T13:11:06+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:06 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:06 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 21 13:11:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access 'MAC': No such file or directory Jun 21 13:11:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access 'MINI': No such file or directory Jun 21 13:11:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:08 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:08 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:09 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:09 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Jun 21 13:11:09 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:09 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:09 volumio-mac-mini go-librespot[3812]: go-librespot daemon starting... Jun 21 13:11:09 volumio-mac-mini go-librespot[3812]: time="2025-06-21T13:11:09+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:09 volumio-mac-mini go-librespot[3812]: time="2025-06-21T13:11:09+02:00" level=debug msg="app state loaded" Jun 21 13:11:09 volumio-mac-mini go-librespot[3812]: time="2025-06-21T13:11:09+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:09 volumio-mac-mini go-librespot[3812]: time="2025-06-21T13:11:09+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:09 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:09 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:11 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:11 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:12 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:12 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Jun 21 13:11:12 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:12 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:12 volumio-mac-mini go-librespot[3839]: go-librespot daemon starting... Jun 21 13:11:12 volumio-mac-mini go-librespot[3839]: time="2025-06-21T13:11:12+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:12 volumio-mac-mini go-librespot[3839]: time="2025-06-21T13:11:12+02:00" level=debug msg="app state loaded" Jun 21 13:11:12 volumio-mac-mini go-librespot[3839]: time="2025-06-21T13:11:12+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:12 volumio-mac-mini go-librespot[3839]: time="2025-06-21T13:11:12+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:12 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:12 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:14 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:14 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:15 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:15 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Jun 21 13:11:15 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:15 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:15 volumio-mac-mini go-librespot[3846]: go-librespot daemon starting... Jun 21 13:11:15 volumio-mac-mini go-librespot[3846]: time="2025-06-21T13:11:15+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:15 volumio-mac-mini go-librespot[3846]: time="2025-06-21T13:11:15+02:00" level=debug msg="app state loaded" Jun 21 13:11:15 volumio-mac-mini go-librespot[3846]: time="2025-06-21T13:11:15+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:15 volumio-mac-mini go-librespot[3846]: time="2025-06-21T13:11:15+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:15 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:15 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:17 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:17 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:19 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:19 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Jun 21 13:11:19 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:19 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:19 volumio-mac-mini go-librespot[3858]: go-librespot daemon starting... Jun 21 13:11:19 volumio-mac-mini go-librespot[3858]: time="2025-06-21T13:11:19+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:19 volumio-mac-mini go-librespot[3858]: time="2025-06-21T13:11:19+02:00" level=debug msg="app state loaded" Jun 21 13:11:19 volumio-mac-mini go-librespot[3858]: time="2025-06-21T13:11:19+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:19 volumio-mac-mini go-librespot[3858]: time="2025-06-21T13:11:19+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:19 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:19 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:20 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:20 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:22 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:22 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Jun 21 13:11:22 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:22 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:22 volumio-mac-mini go-librespot[3884]: go-librespot daemon starting... Jun 21 13:11:22 volumio-mac-mini go-librespot[3884]: time="2025-06-21T13:11:22+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:22 volumio-mac-mini go-librespot[3884]: time="2025-06-21T13:11:22+02:00" level=debug msg="app state loaded" Jun 21 13:11:22 volumio-mac-mini go-librespot[3884]: time="2025-06-21T13:11:22+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:22 volumio-mac-mini go-librespot[3884]: time="2025-06-21T13:11:22+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:22 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:22 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:23 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:23 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:25 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:25 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Jun 21 13:11:25 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:25 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:25 volumio-mac-mini go-librespot[3891]: go-librespot daemon starting... Jun 21 13:11:25 volumio-mac-mini go-librespot[3891]: time="2025-06-21T13:11:25+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:25 volumio-mac-mini go-librespot[3891]: time="2025-06-21T13:11:25+02:00" level=debug msg="app state loaded" Jun 21 13:11:25 volumio-mac-mini go-librespot[3891]: time="2025-06-21T13:11:25+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:25 volumio-mac-mini go-librespot[3891]: time="2025-06-21T13:11:25+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:25 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:25 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:26 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:26 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:28 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:28 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Jun 21 13:11:28 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:28 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:28 volumio-mac-mini go-librespot[3903]: go-librespot daemon starting... Jun 21 13:11:28 volumio-mac-mini go-librespot[3903]: time="2025-06-21T13:11:28+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:28 volumio-mac-mini go-librespot[3903]: time="2025-06-21T13:11:28+02:00" level=debug msg="app state loaded" Jun 21 13:11:28 volumio-mac-mini go-librespot[3903]: time="2025-06-21T13:11:28+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:28 volumio-mac-mini go-librespot[3903]: time="2025-06-21T13:11:28+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:28 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:28 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:29 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:29 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:32 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:32 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Jun 21 13:11:32 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:32 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:32 volumio-mac-mini go-librespot[3927]: go-librespot daemon starting... Jun 21 13:11:32 volumio-mac-mini go-librespot[3927]: time="2025-06-21T13:11:32+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:32 volumio-mac-mini go-librespot[3927]: time="2025-06-21T13:11:32+02:00" level=debug msg="app state loaded" Jun 21 13:11:32 volumio-mac-mini go-librespot[3927]: time="2025-06-21T13:11:32+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:32 volumio-mac-mini go-librespot[3927]: time="2025-06-21T13:11:32+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:32 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:32 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:32 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:32 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:35 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:35 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 105. Jun 21 13:11:35 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:35 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:35 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:35 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:35 volumio-mac-mini go-librespot[3939]: go-librespot daemon starting... Jun 21 13:11:35 volumio-mac-mini go-librespot[3939]: time="2025-06-21T13:11:35+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:35 volumio-mac-mini go-librespot[3939]: time="2025-06-21T13:11:35+02:00" level=debug msg="app state loaded" Jun 21 13:11:35 volumio-mac-mini go-librespot[3939]: time="2025-06-21T13:11:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:35 volumio-mac-mini go-librespot[3939]: time="2025-06-21T13:11:35+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:35 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:35 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:38 volumio-mac-mini ntpd[1019]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 21 13:11:38 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:38 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:38 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:38 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 106. Jun 21 13:11:38 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:38 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:38 volumio-mac-mini go-librespot[3951]: go-librespot daemon starting... Jun 21 13:11:38 volumio-mac-mini go-librespot[3951]: time="2025-06-21T13:11:38+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:38 volumio-mac-mini go-librespot[3951]: time="2025-06-21T13:11:38+02:00" level=debug msg="app state loaded" Jun 21 13:11:38 volumio-mac-mini go-librespot[3951]: time="2025-06-21T13:11:38+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:38 volumio-mac-mini go-librespot[3951]: time="2025-06-21T13:11:38+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:38 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:38 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:41 volumio-mac-mini ntpd[1019]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 21 13:11:41 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:41 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:41 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:41 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 107. Jun 21 13:11:41 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:41 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:41 volumio-mac-mini go-librespot[3972]: go-librespot daemon starting... Jun 21 13:11:41 volumio-mac-mini go-librespot[3972]: time="2025-06-21T13:11:41+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:41 volumio-mac-mini go-librespot[3972]: time="2025-06-21T13:11:41+02:00" level=debug msg="app state loaded" Jun 21 13:11:41 volumio-mac-mini go-librespot[3972]: time="2025-06-21T13:11:41+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:41 volumio-mac-mini go-librespot[3972]: time="2025-06-21T13:11:41+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:41 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:41 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:43 volumio-mac-mini ntpd[1019]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 21 13:11:44 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:44 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:45 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:45 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 108. Jun 21 13:11:45 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:45 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:45 volumio-mac-mini go-librespot[3984]: go-librespot daemon starting... Jun 21 13:11:45 volumio-mac-mini go-librespot[3984]: time="2025-06-21T13:11:45+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:45 volumio-mac-mini go-librespot[3984]: time="2025-06-21T13:11:45+02:00" level=debug msg="app state loaded" Jun 21 13:11:45 volumio-mac-mini go-librespot[3984]: time="2025-06-21T13:11:45+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:45 volumio-mac-mini go-librespot[3984]: time="2025-06-21T13:11:45+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:45 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:45 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:45 volumio-mac-mini ntpd[1019]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 21 13:11:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:47 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:47 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:48 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:48 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 109. Jun 21 13:11:48 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:48 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:48 volumio-mac-mini go-librespot[3996]: go-librespot daemon starting... Jun 21 13:11:48 volumio-mac-mini go-librespot[3996]: time="2025-06-21T13:11:48+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:48 volumio-mac-mini go-librespot[3996]: time="2025-06-21T13:11:48+02:00" level=debug msg="app state loaded" Jun 21 13:11:48 volumio-mac-mini go-librespot[3996]: time="2025-06-21T13:11:48+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:48 volumio-mac-mini go-librespot[3996]: time="2025-06-21T13:11:48+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:48 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:48 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:50 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:50 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:51 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:51 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 110. Jun 21 13:11:51 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:51 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:51 volumio-mac-mini go-librespot[4020]: go-librespot daemon starting... Jun 21 13:11:51 volumio-mac-mini go-librespot[4020]: time="2025-06-21T13:11:51+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:51 volumio-mac-mini go-librespot[4020]: time="2025-06-21T13:11:51+02:00" level=debug msg="app state loaded" Jun 21 13:11:51 volumio-mac-mini go-librespot[4020]: time="2025-06-21T13:11:51+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:51 volumio-mac-mini go-librespot[4020]: time="2025-06-21T13:11:51+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:51 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:51 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:53 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:53 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:54 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:54 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 111. Jun 21 13:11:54 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:54 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:54 volumio-mac-mini go-librespot[4032]: go-librespot daemon starting... Jun 21 13:11:54 volumio-mac-mini go-librespot[4032]: time="2025-06-21T13:11:54+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:54 volumio-mac-mini go-librespot[4032]: time="2025-06-21T13:11:54+02:00" level=debug msg="app state loaded" Jun 21 13:11:54 volumio-mac-mini go-librespot[4032]: time="2025-06-21T13:11:54+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:54 volumio-mac-mini go-librespot[4032]: time="2025-06-21T13:11:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:54 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:54 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:56 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:56 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:11:57 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:11:57 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:11:57 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:11:58 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:11:58 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 112. Jun 21 13:11:58 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:11:58 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:11:58 volumio-mac-mini go-librespot[4044]: go-librespot daemon starting... Jun 21 13:11:58 volumio-mac-mini go-librespot[4044]: time="2025-06-21T13:11:58+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:11:58 volumio-mac-mini go-librespot[4044]: time="2025-06-21T13:11:58+02:00" level=debug msg="app state loaded" Jun 21 13:11:58 volumio-mac-mini go-librespot[4044]: time="2025-06-21T13:11:58+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:11:58 volumio-mac-mini go-librespot[4044]: time="2025-06-21T13:11:58+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:11:58 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:11:58 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:11:59 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:11:59 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:01 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:01 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 113. Jun 21 13:12:01 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:01 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:01 volumio-mac-mini go-librespot[4065]: go-librespot daemon starting... Jun 21 13:12:01 volumio-mac-mini go-librespot[4065]: time="2025-06-21T13:12:01+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:01 volumio-mac-mini go-librespot[4065]: time="2025-06-21T13:12:01+02:00" level=debug msg="app state loaded" Jun 21 13:12:01 volumio-mac-mini go-librespot[4065]: time="2025-06-21T13:12:01+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:01 volumio-mac-mini go-librespot[4065]: time="2025-06-21T13:12:01+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:01 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:01 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:02 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:02 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:02 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:04 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:04 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 114. Jun 21 13:12:04 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:04 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:04 volumio-mac-mini go-librespot[4077]: go-librespot daemon starting... Jun 21 13:12:04 volumio-mac-mini go-librespot[4077]: time="2025-06-21T13:12:04+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:04 volumio-mac-mini go-librespot[4077]: time="2025-06-21T13:12:04+02:00" level=debug msg="app state loaded" Jun 21 13:12:04 volumio-mac-mini go-librespot[4077]: time="2025-06-21T13:12:04+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:04 volumio-mac-mini go-librespot[4077]: time="2025-06-21T13:12:04+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:04 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:04 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:05 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:05 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 21 13:12:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access 'MAC': No such file or directory Jun 21 13:12:06 volumio-mac-mini volumiologrotate[732]: ls: cannot access 'MINI': No such file or directory Jun 21 13:12:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:07 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:07 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:07 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 115. Jun 21 13:12:07 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:07 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:07 volumio-mac-mini go-librespot[4139]: go-librespot daemon starting... Jun 21 13:12:07 volumio-mac-mini go-librespot[4139]: time="2025-06-21T13:12:07+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:07 volumio-mac-mini go-librespot[4139]: time="2025-06-21T13:12:07+02:00" level=debug msg="app state loaded" Jun 21 13:12:07 volumio-mac-mini go-librespot[4139]: time="2025-06-21T13:12:07+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:07 volumio-mac-mini go-librespot[4139]: time="2025-06-21T13:12:07+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:07 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:07 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:08 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:08 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:11 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:11 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 116. Jun 21 13:12:11 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:11 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:11 volumio-mac-mini go-librespot[4163]: go-librespot daemon starting... Jun 21 13:12:11 volumio-mac-mini go-librespot[4163]: time="2025-06-21T13:12:11+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:11 volumio-mac-mini go-librespot[4163]: time="2025-06-21T13:12:11+02:00" level=debug msg="app state loaded" Jun 21 13:12:11 volumio-mac-mini go-librespot[4163]: time="2025-06-21T13:12:11+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:11 volumio-mac-mini go-librespot[4163]: time="2025-06-21T13:12:11+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:11 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:11 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:11 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:11 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:12 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:14 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:14 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 117. Jun 21 13:12:14 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:14 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:14 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:14 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:14 volumio-mac-mini go-librespot[4175]: go-librespot daemon starting... Jun 21 13:12:14 volumio-mac-mini go-librespot[4175]: time="2025-06-21T13:12:14+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:14 volumio-mac-mini go-librespot[4175]: time="2025-06-21T13:12:14+02:00" level=debug msg="app state loaded" Jun 21 13:12:14 volumio-mac-mini go-librespot[4175]: time="2025-06-21T13:12:14+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:14 volumio-mac-mini go-librespot[4175]: time="2025-06-21T13:12:14+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:14 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:14 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:17 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:17 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:17 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:17 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:17 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 118. Jun 21 13:12:17 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:17 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:17 volumio-mac-mini go-librespot[4187]: go-librespot daemon starting... Jun 21 13:12:17 volumio-mac-mini go-librespot[4187]: time="2025-06-21T13:12:17+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:17 volumio-mac-mini go-librespot[4187]: time="2025-06-21T13:12:17+02:00" level=debug msg="app state loaded" Jun 21 13:12:17 volumio-mac-mini go-librespot[4187]: time="2025-06-21T13:12:17+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:17 volumio-mac-mini go-librespot[4187]: time="2025-06-21T13:12:17+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:17 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:17 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:20 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:20 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:20 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:20 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 119. Jun 21 13:12:20 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:20 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:20 volumio-mac-mini go-librespot[4194]: go-librespot daemon starting... Jun 21 13:12:20 volumio-mac-mini go-librespot[4194]: time="2025-06-21T13:12:20+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:20 volumio-mac-mini go-librespot[4194]: time="2025-06-21T13:12:20+02:00" level=debug msg="app state loaded" Jun 21 13:12:20 volumio-mac-mini go-librespot[4194]: time="2025-06-21T13:12:20+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:20 volumio-mac-mini go-librespot[4194]: time="2025-06-21T13:12:20+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:20 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:20 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:22 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:23 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:23 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:24 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:24 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 120. Jun 21 13:12:24 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:24 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:24 volumio-mac-mini go-librespot[4220]: go-librespot daemon starting... Jun 21 13:12:24 volumio-mac-mini go-librespot[4220]: time="2025-06-21T13:12:24+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:24 volumio-mac-mini go-librespot[4220]: time="2025-06-21T13:12:24+02:00" level=debug msg="app state loaded" Jun 21 13:12:24 volumio-mac-mini go-librespot[4220]: time="2025-06-21T13:12:24+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:24 volumio-mac-mini go-librespot[4220]: time="2025-06-21T13:12:24+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:24 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:24 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:26 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:26 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:27 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:27 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:27 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 121. Jun 21 13:12:27 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:27 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:27 volumio-mac-mini go-librespot[4232]: go-librespot daemon starting... Jun 21 13:12:27 volumio-mac-mini go-librespot[4232]: time="2025-06-21T13:12:27+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:27 volumio-mac-mini go-librespot[4232]: time="2025-06-21T13:12:27+02:00" level=debug msg="app state loaded" Jun 21 13:12:27 volumio-mac-mini go-librespot[4232]: time="2025-06-21T13:12:27+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:27 volumio-mac-mini go-librespot[4232]: time="2025-06-21T13:12:27+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:27 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:27 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:29 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:29 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:30 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:30 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 122. Jun 21 13:12:30 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:30 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:30 volumio-mac-mini go-librespot[4242]: go-librespot daemon starting... Jun 21 13:12:30 volumio-mac-mini go-librespot[4242]: time="2025-06-21T13:12:30+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:30 volumio-mac-mini go-librespot[4242]: time="2025-06-21T13:12:30+02:00" level=debug msg="app state loaded" Jun 21 13:12:30 volumio-mac-mini go-librespot[4242]: time="2025-06-21T13:12:30+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:30 volumio-mac-mini go-librespot[4242]: time="2025-06-21T13:12:30+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:30 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:30 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:32 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:32 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:32 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:33 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:33 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 123. Jun 21 13:12:33 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:33 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:33 volumio-mac-mini go-librespot[4268]: go-librespot daemon starting... Jun 21 13:12:33 volumio-mac-mini go-librespot[4268]: time="2025-06-21T13:12:33+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:33 volumio-mac-mini go-librespot[4268]: time="2025-06-21T13:12:33+02:00" level=debug msg="app state loaded" Jun 21 13:12:33 volumio-mac-mini go-librespot[4268]: time="2025-06-21T13:12:33+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:33 volumio-mac-mini go-librespot[4268]: time="2025-06-21T13:12:33+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:33 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:33 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:35 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:35 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:37 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:37 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 124. Jun 21 13:12:37 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:37 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:37 volumio-mac-mini go-librespot[4275]: go-librespot daemon starting... Jun 21 13:12:37 volumio-mac-mini go-librespot[4275]: time="2025-06-21T13:12:37+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:37 volumio-mac-mini go-librespot[4275]: time="2025-06-21T13:12:37+02:00" level=debug msg="app state loaded" Jun 21 13:12:37 volumio-mac-mini go-librespot[4275]: time="2025-06-21T13:12:37+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:37 volumio-mac-mini go-librespot[4275]: time="2025-06-21T13:12:37+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:37 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:37 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:37 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:38 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:38 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:40 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:40 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 125. Jun 21 13:12:40 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:40 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:40 volumio-mac-mini go-librespot[4287]: go-librespot daemon starting... Jun 21 13:12:40 volumio-mac-mini go-librespot[4287]: time="2025-06-21T13:12:40+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:40 volumio-mac-mini go-librespot[4287]: time="2025-06-21T13:12:40+02:00" level=debug msg="app state loaded" Jun 21 13:12:40 volumio-mac-mini go-librespot[4287]: time="2025-06-21T13:12:40+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:40 volumio-mac-mini go-librespot[4287]: time="2025-06-21T13:12:40+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:40 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:40 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:41 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:41 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:41 volumio-mac-mini kernel: tg3 0000:03:00.0 eth0: Link is up at 100 Mbps, full duplex Jun 21 13:12:41 volumio-mac-mini kernel: tg3 0000:03:00.0 eth0: Flow control is off for TX and off for RX Jun 21 13:12:41 volumio-mac-mini kernel: tg3 0000:03:00.0 eth0: EEE is disabled Jun 21 13:12:41 volumio-mac-mini dhcpcd[1610]: eth0: carrier acquired Jun 21 13:12:41 volumio-mac-mini dhcpcd[1610]: eth0: IAID eb:cc:10:dc Jun 21 13:12:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:42 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:42 volumio-mac-mini ifplugd(eth0)[1011]: Link beat detected. Jun 21 13:12:42 volumio-mac-mini ifplugd(eth0)[1011]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 21 13:12:42 volumio-mac-mini ifplugd(eth0)[1011]: client: command failed: No such device (-19) Jun 21 13:12:42 volumio-mac-mini dhcpcd[4336]: sending commands to master dhcpcd process Jun 21 13:12:42 volumio-mac-mini dhcpcd[786]: control command: /sbin/dhcpcd eth0 Jun 21 13:12:42 volumio-mac-mini ifplugd(eth0)[1011]: client: sending commands to master dhcpcd process Jun 21 13:12:42 volumio-mac-mini dhcpcd[786]: eth0: carrier acquired Jun 21 13:12:42 volumio-mac-mini dhcpcd[786]: eth0: IAID eb:cc:10:dc Jun 21 13:12:42 volumio-mac-mini dhcpcd[1610]: eth0: soliciting an IPv6 router Jun 21 13:12:42 volumio-mac-mini ifplugd(eth0)[1011]: Program executed successfully. Jun 21 13:12:42 volumio-mac-mini dhcpcd[1610]: eth0: soliciting a DHCP lease Jun 21 13:12:42 volumio-mac-mini dhcpcd[1610]: eth0: offered 192.168.0.101 from 192.168.0.1 Jun 21 13:12:43 volumio-mac-mini dhcpcd[786]: eth0: soliciting a DHCP lease Jun 21 13:12:43 volumio-mac-mini dhcpcd[786]: eth0: soliciting an IPv6 router Jun 21 13:12:43 volumio-mac-mini ntpd[1019]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 21 13:12:43 volumio-mac-mini dhcpcd[786]: eth0: offered 192.168.0.101 from 192.168.0.1 Jun 21 13:12:43 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:43 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 126. Jun 21 13:12:43 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:43 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:43 volumio-mac-mini go-librespot[4363]: go-librespot daemon starting... Jun 21 13:12:43 volumio-mac-mini go-librespot[4363]: time="2025-06-21T13:12:43+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:43 volumio-mac-mini go-librespot[4363]: time="2025-06-21T13:12:43+02:00" level=debug msg="app state loaded" Jun 21 13:12:43 volumio-mac-mini go-librespot[4363]: time="2025-06-21T13:12:43+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:43 volumio-mac-mini go-librespot[4363]: time="2025-06-21T13:12:43+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:43 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:43 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:44 volumio-mac-mini dhcpcd[786]: eth0: probing address 192.168.0.101/24 Jun 21 13:12:44 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:44 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:46 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:46 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 127. Jun 21 13:12:46 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:46 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:46 volumio-mac-mini go-librespot[4370]: go-librespot daemon starting... Jun 21 13:12:46 volumio-mac-mini go-librespot[4370]: time="2025-06-21T13:12:46+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:46 volumio-mac-mini go-librespot[4370]: time="2025-06-21T13:12:46+02:00" level=debug msg="app state loaded" Jun 21 13:12:46 volumio-mac-mini go-librespot[4370]: time="2025-06-21T13:12:46+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:46 volumio-mac-mini go-librespot[4370]: time="2025-06-21T13:12:46+02:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 21 13:12:46 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 21 13:12:46 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 21 13:12:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Date not found in response Jun 21 13:12:47 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Retrying in 5 seconds... Jun 21 13:12:47 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:47 volumio-mac-mini volumio[991]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jun 21 13:12:47 volumio-mac-mini dhcpcd[1610]: eth0: probing for an IPv4LL address Jun 21 13:12:48 volumio-mac-mini dhcpcd[1610]: eth0: probing address 192.168.0.101/24 Jun 21 13:12:48 volumio-mac-mini ntpd[1019]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 21 13:12:49 volumio-mac-mini ntpd[1019]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 21 13:12:49 volumio-mac-mini dhcpcd[786]: eth0: leased 192.168.0.101 for 7200 seconds Jun 21 13:12:49 volumio-mac-mini dhcpcd[786]: eth0: adding route to 192.168.0.0/24 Jun 21 13:12:49 volumio-mac-mini dhcpcd[786]: eth0: adding default route via 192.168.0.1 Jun 21 13:12:49 volumio-mac-mini avahi-daemon[731]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.101. Jun 21 13:12:49 volumio-mac-mini avahi-daemon[731]: New relevant interface eth0.IPv4 for mDNS. Jun 21 13:12:49 volumio-mac-mini avahi-daemon[731]: Registering new address record for 192.168.0.101 on eth0.IPv4. Jun 21 13:12:49 volumio-mac-mini ntpd[1019]: ntpd exiting on signal 15 (Terminated) Jun 21 13:12:49 volumio-mac-mini systemd[1]: Stopping Network Time Service... Jun 21 13:12:49 volumio-mac-mini systemd[1]: ntp.service: Succeeded. Jun 21 13:12:49 volumio-mac-mini systemd[1]: Stopped Network Time Service. Jun 21 13:12:49 volumio-mac-mini systemd[1]: Starting Network Time Service... Jun 21 13:12:49 volumio-mac-mini ntpd[4420]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 21 13:12:49 volumio-mac-mini ntpd[4420]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 21 13:12:49 volumio-mac-mini systemd[1]: Started Network Time Service. Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: proto: precision = 0.106 usec (-23) Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 907 days ago Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: Listen and drop on 0 v6wildcard [::]:123 Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: Listen normally on 2 lo 127.0.0.1:123 Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: Listen normally on 3 eth0 192.168.0.101:123 Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: Listening on routing socket on fd #20 for interface updates Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 21 13:12:49 volumio-mac-mini ntpd[4427]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 21 13:12:50 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 21 13:12:50 volumio-mac-mini systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 128. Jun 21 13:12:50 volumio-mac-mini systemd[1]: Stopped go-librespot Daemon. Jun 21 13:12:50 volumio-mac-mini systemd[1]: Started go-librespot Daemon. Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: go-librespot daemon starting... Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=info msg="running go-librespot 0.2.0" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="app state loaded" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=info msg="zeroconf server listening on port 33411" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="obtained new client token: AABh5v+fzXNPU7vNES4ZgPas0R1XtKGAz9moZLO9CKAc9SMkXfrNw3lOvabri5YH2AIs8LW18wDZhuWqiuxO9H8ExkoftIJiz3shuEGyN75NacAmdyWX3rbWCqY5r2OMTJpuA341MB3FFZ40A1r5+w1L2r4mVeNkcXW5NmuBg1ecLu+9yg2bvtY85QHC84pcdfEbfyEKLr/XWBZpdLZM+TI2bP5fpdpeh8VAnyKj7nyxRp2fNzU8yNs/" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="completed keyexchange" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="completed challenge" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=info msg="authenticated AP as 31gkhucyhxag5ko2ek3hthw4qdxm" Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Initializing connection to go-librespot Websocket Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="new websocket client" Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Connection to go-librespot Websocket established Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=info msg="authenticated Login5 as 31gkhucyhxag5ko2ek3hthw4qdxm" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="initializing zeroconf session, username: 31gkhucyhxag5ko2ek3hthw4qdxm" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="dealer connection opened" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=trace msg="starting accesspoint recv loop" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=trace msg="starting dealer recv loop" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=trace msg="received accesspoint ping" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="received connection id: ZWY1YWU3ZjEtYTQ5OC00N2JjLWJmYTgtZTQ4ZjBhNTczNTUyK2RlYWxlcit0Y3A6Ly8wYWNhNThkMy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMzhDOTU3NjgwRUY1RDdFRTMzNEVFQzY5NTNEQzkxRDQ5NzhBNjJDODU5REI2OTI0NDRDRTZCRTI4NTlBMDJDNg==" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=trace msg="received accesspoint pong ack" Jun 21 13:12:50 volumio-mac-mini go-librespot[4443]: time="2025-06-21T13:12:50+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Discovery: adding a813c687-5336-4a7c-b0f1-65f6e30b06f2 Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Discovery: Found device Volumio Mac mini Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: CoreCommandRouter::volumioGetState Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: CorePlayQueue::getTrack 0 Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin bluetooth to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin multiroom to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin metavolumio to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin cd_controller to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 21 13:12:50 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: Starting MyVolumio Remote Streaming Endpoints Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: MyVolumio login type: Token Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: Starting Streaming Service Transparent Proxy Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: Streaming services startup Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: Starting Streaming Daemon Jun 21 13:12:51 volumio-mac-mini sudo[4475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 21 13:12:51 volumio-mac-mini sudo[4475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 13:12:51 volumio-mac-mini sudo[4475]: pam_unix(sudo:session): session closed for user root Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: Volumio Network Manager: Network status updated: 1 Jun 21 13:12:51 volumio-mac-mini volumio[991]: error: Cannot start Volumio Streaming Daemon Jun 21 13:12:51 volumio-mac-mini volumio[991]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 21 13:12:51 volumio-mac-mini volumio[991]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 21 13:12:51 volumio-mac-mini ntpd[4427]: Soliciting pool server 89.161.47.136 Jun 21 13:12:51 volumio-mac-mini volumio[991]: STREAMING PROXY: Starting server on port 3245 Jun 21 13:12:51 volumio-mac-mini volumio[991]: Node JS runtime: 14 Jun 21 13:12:51 volumio-mac-mini ntpd[4427]: Soliciting pool server 195.46.37.22 Jun 21 13:12:51 volumio-mac-mini ntpd[4427]: Soliciting pool server 91.212.242.20 Jun 21 13:12:51 volumio-mac-mini volumio[991]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: Discovery: Getting this device information Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: CoreCommandRouter::volumioGetState Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: CorePlayQueue::getTrack 0 Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 21 13:12:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Fetching time from Volumio... Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MyVolumio token set successfully Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MYVOLUMIO: Adding device Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MYVOLUMIO: Evaluating Server Jun 21 13:12:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: Setting system time to: 2025-06-21 13:12:52 Jun 21 13:12:52 volumio-mac-mini sudo[4488]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-21 13:12:52 Jun 21 13:12:52 volumio-mac-mini sudo[4488]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 21 13:12:52 volumio-mac-mini dbus-daemon[720]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.17' (uid=0 pid=4489 comm="timedatectl set-time 2025-06-21 13:12:52 ") Jun 21 13:12:52 volumio-mac-mini systemd[1]: Starting Time & Date Service... Jun 21 13:12:52 volumio-mac-mini dbus-daemon[720]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 21 13:12:52 volumio-mac-mini systemd[1]: Started Time & Date Service. Jun 21 13:12:52 volumio-mac-mini systemd-timedated[4490]: Changed local time to Sat Jun 21 13:12:52 2025 Jun 21 13:12:52 volumio-mac-mini sudo[4488]: pam_unix(sudo:session): session closed for user root Jun 21 13:12:52 volumio-mac-mini volumio-time-update[712]: volumio-time-update-util: System time updated successfully. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Started Volumio Time Update Utility. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Reached target Multi-User System. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Reached target Graphical Interface. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 21 13:12:52 volumio-mac-mini systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 21 13:12:52 volumio-mac-mini systemd[1]: Startup finished in 5.648s (kernel) + 7min 48.673s (userspace) = 7min 54.321s. Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MyVolumio Plan changed: premium Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: Removing browser output: myVolumio user plan is not superstar Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: Removing audio output: Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MYVOLUMIO: Adding device Jun 21 13:12:52 volumio-mac-mini volumio[991]: info: MYVOLUMIO: Evaluating Server Jun 21 13:12:52 volumio-mac-mini volumio[991]: error: Failed to ping endpoint eu2.myvolumio.org : unknown error Jun 21 13:12:52 volumio-mac-mini volumio[991]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 13:12:52 volumio-mac-mini volumio[991]: Error: Unable to resolve or reject the same promise twice Jun 21 13:12:52 volumio-mac-mini volumio[991]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at Socket.emit (events.js:400:28) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at addChunk (internal/streams/readable.js:293:12) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at readableAddChunk (internal/streams/readable.js:267:9) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at Socket.Readable.push (internal/streams/readable.js:206:10) Jun 21 13:12:52 volumio-mac-mini volumio[991]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 21 13:12:52 volumio-mac-mini volumio[991]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 13:12:52 volumio-mac-mini sudo[4517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 13:11 Jun 21 13:12:52 volumio-mac-mini sudo[4517]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"