Dec 06 00:29:00 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3052. Dec 06 00:29:00 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:00 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:00 marty go-librespot[9996]: go-librespot daemon starting... Dec 06 00:29:00 marty go-librespot[9997]: time="2025-12-06T00:29:00+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:00 marty go-librespot[9997]: time="2025-12-06T00:29:00+01:00" level=debug msg="app state loaded" Dec 06 00:29:00 marty go-librespot[9997]: time="2025-12-06T00:29:00+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:00 marty go-librespot[9997]: time="2025-12-06T00:29:00+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:00 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:00 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:01 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:01 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:03 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3053. Dec 06 00:29:03 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:03 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:03 marty go-librespot[10003]: go-librespot daemon starting... Dec 06 00:29:03 marty go-librespot[10004]: time="2025-12-06T00:29:03+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:03 marty go-librespot[10004]: time="2025-12-06T00:29:03+01:00" level=debug msg="app state loaded" Dec 06 00:29:03 marty go-librespot[10004]: time="2025-12-06T00:29:03+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:03 marty go-librespot[10004]: time="2025-12-06T00:29:03+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:03 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:03 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:04 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:04 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:06 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3054. Dec 06 00:29:06 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:07 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:07 marty go-librespot[10025]: go-librespot daemon starting... Dec 06 00:29:07 marty go-librespot[10026]: time="2025-12-06T00:29:07+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:07 marty go-librespot[10026]: time="2025-12-06T00:29:07+01:00" level=debug msg="app state loaded" Dec 06 00:29:07 marty go-librespot[10026]: time="2025-12-06T00:29:07+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:07 marty go-librespot[10026]: time="2025-12-06T00:29:07+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:07 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:07 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:07 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:07 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:10 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3055. Dec 06 00:29:10 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:10 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:10 marty go-librespot[10033]: go-librespot daemon starting... Dec 06 00:29:10 marty go-librespot[10034]: time="2025-12-06T00:29:10+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:10 marty go-librespot[10034]: time="2025-12-06T00:29:10+01:00" level=debug msg="app state loaded" Dec 06 00:29:10 marty go-librespot[10034]: time="2025-12-06T00:29:10+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:10 marty go-librespot[10034]: time="2025-12-06T00:29:10+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:10 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:10 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:10 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:10 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:13 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3056. Dec 06 00:29:13 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:13 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:13 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:13 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:13 marty go-librespot[10043]: go-librespot daemon starting... Dec 06 00:29:13 marty go-librespot[10044]: time="2025-12-06T00:29:13+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:13 marty go-librespot[10044]: time="2025-12-06T00:29:13+01:00" level=debug msg="app state loaded" Dec 06 00:29:13 marty go-librespot[10044]: time="2025-12-06T00:29:13+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:13 marty go-librespot[10044]: time="2025-12-06T00:29:13+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:13 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:13 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:16 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:16 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:16 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3057. Dec 06 00:29:16 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:16 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:16 marty go-librespot[10065]: go-librespot daemon starting... Dec 06 00:29:16 marty go-librespot[10066]: time="2025-12-06T00:29:16+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:16 marty go-librespot[10066]: time="2025-12-06T00:29:16+01:00" level=debug msg="app state loaded" Dec 06 00:29:16 marty go-librespot[10066]: time="2025-12-06T00:29:16+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:16 marty go-librespot[10066]: time="2025-12-06T00:29:16+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:16 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:16 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:19 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:19 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:19 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3058. Dec 06 00:29:19 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:20 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:20 marty go-librespot[10072]: go-librespot daemon starting... Dec 06 00:29:20 marty go-librespot[10073]: time="2025-12-06T00:29:20+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:20 marty go-librespot[10073]: time="2025-12-06T00:29:20+01:00" level=debug msg="app state loaded" Dec 06 00:29:20 marty go-librespot[10073]: time="2025-12-06T00:29:20+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:20 marty go-librespot[10073]: time="2025-12-06T00:29:20+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:20 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:20 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:22 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:22 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:23 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3059. Dec 06 00:29:23 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:23 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:23 marty go-librespot[10079]: go-librespot daemon starting... Dec 06 00:29:23 marty go-librespot[10080]: time="2025-12-06T00:29:23+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:23 marty go-librespot[10080]: time="2025-12-06T00:29:23+01:00" level=debug msg="app state loaded" Dec 06 00:29:23 marty go-librespot[10080]: time="2025-12-06T00:29:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:23 marty go-librespot[10080]: time="2025-12-06T00:29:23+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:23 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:23 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:25 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:25 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:26 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3060. Dec 06 00:29:26 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:26 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:26 marty go-librespot[10101]: go-librespot daemon starting... Dec 06 00:29:26 marty go-librespot[10102]: time="2025-12-06T00:29:26+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:26 marty go-librespot[10102]: time="2025-12-06T00:29:26+01:00" level=debug msg="app state loaded" Dec 06 00:29:26 marty go-librespot[10102]: time="2025-12-06T00:29:26+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:26 marty go-librespot[10102]: time="2025-12-06T00:29:26+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:26 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:26 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:28 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:28 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:29 marty nmbd[1142]: [2025/12/06 00:29:29.401061, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 06 00:29:29 marty nmbd[1142]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.2.122 for name WORKGROUP<1d>. Dec 06 00:29:29 marty nmbd[1142]: This response was from IP 192.168.2.97, reporting an IP address of 192.168.2.97. Dec 06 00:29:29 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3061. Dec 06 00:29:29 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:29 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:29 marty go-librespot[10109]: go-librespot daemon starting... Dec 06 00:29:29 marty go-librespot[10110]: time="2025-12-06T00:29:29+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:29 marty go-librespot[10110]: time="2025-12-06T00:29:29+01:00" level=debug msg="app state loaded" Dec 06 00:29:29 marty go-librespot[10110]: time="2025-12-06T00:29:29+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:29 marty go-librespot[10110]: time="2025-12-06T00:29:29+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:29 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:29 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:31 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:31 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:32 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3062. Dec 06 00:29:32 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:33 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:33 marty go-librespot[10119]: go-librespot daemon starting... Dec 06 00:29:33 marty go-librespot[10120]: time="2025-12-06T00:29:33+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:33 marty go-librespot[10120]: time="2025-12-06T00:29:33+01:00" level=debug msg="app state loaded" Dec 06 00:29:33 marty go-librespot[10120]: time="2025-12-06T00:29:33+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:33 marty go-librespot[10120]: time="2025-12-06T00:29:33+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:33 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:33 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:34 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:34 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:36 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3063. Dec 06 00:29:36 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:36 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:36 marty go-librespot[10142]: go-librespot daemon starting... Dec 06 00:29:36 marty go-librespot[10143]: time="2025-12-06T00:29:36+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:36 marty go-librespot[10143]: time="2025-12-06T00:29:36+01:00" level=debug msg="app state loaded" Dec 06 00:29:36 marty go-librespot[10143]: time="2025-12-06T00:29:36+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:36 marty go-librespot[10143]: time="2025-12-06T00:29:36+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:36 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:36 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:37 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:37 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:39 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3064. Dec 06 00:29:39 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:39 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:39 marty go-librespot[10150]: go-librespot daemon starting... Dec 06 00:29:39 marty go-librespot[10151]: time="2025-12-06T00:29:39+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:39 marty go-librespot[10151]: time="2025-12-06T00:29:39+01:00" level=debug msg="app state loaded" Dec 06 00:29:39 marty go-librespot[10151]: time="2025-12-06T00:29:39+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:39 marty go-librespot[10151]: time="2025-12-06T00:29:39+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:39 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:39 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:40 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:40 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:42 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3065. Dec 06 00:29:42 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:42 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:42 marty go-librespot[10157]: go-librespot daemon starting... Dec 06 00:29:42 marty go-librespot[10158]: time="2025-12-06T00:29:42+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:42 marty go-librespot[10158]: time="2025-12-06T00:29:42+01:00" level=debug msg="app state loaded" Dec 06 00:29:42 marty go-librespot[10158]: time="2025-12-06T00:29:42+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:42 marty go-librespot[10158]: time="2025-12-06T00:29:42+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:42 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:42 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:43 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:43 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:45 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3066. Dec 06 00:29:45 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:45 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:45 marty go-librespot[10179]: go-librespot daemon starting... Dec 06 00:29:46 marty go-librespot[10180]: time="2025-12-06T00:29:46+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:46 marty go-librespot[10180]: time="2025-12-06T00:29:46+01:00" level=debug msg="app state loaded" Dec 06 00:29:46 marty go-librespot[10180]: time="2025-12-06T00:29:46+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:46 marty go-librespot[10180]: time="2025-12-06T00:29:46+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:46 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:46 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:46 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:46 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:49 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3067. Dec 06 00:29:49 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:49 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:49 marty go-librespot[10188]: go-librespot daemon starting... Dec 06 00:29:49 marty go-librespot[10189]: time="2025-12-06T00:29:49+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:49 marty go-librespot[10189]: time="2025-12-06T00:29:49+01:00" level=debug msg="app state loaded" Dec 06 00:29:49 marty go-librespot[10189]: time="2025-12-06T00:29:49+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:49 marty go-librespot[10189]: time="2025-12-06T00:29:49+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:49 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:49 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:49 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:49 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:52 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3068. Dec 06 00:29:52 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:52 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:52 marty go-librespot[10199]: go-librespot daemon starting... Dec 06 00:29:52 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:52 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:52 marty go-librespot[10200]: time="2025-12-06T00:29:52+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:52 marty go-librespot[10200]: time="2025-12-06T00:29:52+01:00" level=debug msg="app state loaded" Dec 06 00:29:52 marty go-librespot[10200]: time="2025-12-06T00:29:52+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:52 marty go-librespot[10200]: time="2025-12-06T00:29:52+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:52 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:52 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:55 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:55 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:55 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3069. Dec 06 00:29:55 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:55 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:55 marty go-librespot[10221]: go-librespot daemon starting... Dec 06 00:29:55 marty go-librespot[10222]: time="2025-12-06T00:29:55+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:55 marty go-librespot[10222]: time="2025-12-06T00:29:55+01:00" level=debug msg="app state loaded" Dec 06 00:29:55 marty go-librespot[10222]: time="2025-12-06T00:29:55+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:55 marty go-librespot[10222]: time="2025-12-06T00:29:55+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:55 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:55 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:29:58 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:29:58 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:29:58 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3070. Dec 06 00:29:58 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:59 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:29:59 marty go-librespot[10228]: go-librespot daemon starting... Dec 06 00:29:59 marty go-librespot[10229]: time="2025-12-06T00:29:59+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:29:59 marty go-librespot[10229]: time="2025-12-06T00:29:59+01:00" level=debug msg="app state loaded" Dec 06 00:29:59 marty go-librespot[10229]: time="2025-12-06T00:29:59+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:29:59 marty go-librespot[10229]: time="2025-12-06T00:29:59+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:29:59 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:29:59 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:01 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:01 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:02 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3071. Dec 06 00:30:02 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:02 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:02 marty go-librespot[10235]: go-librespot daemon starting... Dec 06 00:30:02 marty go-librespot[10236]: time="2025-12-06T00:30:02+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:02 marty go-librespot[10236]: time="2025-12-06T00:30:02+01:00" level=debug msg="app state loaded" Dec 06 00:30:02 marty go-librespot[10236]: time="2025-12-06T00:30:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:02 marty go-librespot[10236]: time="2025-12-06T00:30:02+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:02 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:02 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:04 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:04 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:05 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3072. Dec 06 00:30:05 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:05 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:05 marty go-librespot[10258]: go-librespot daemon starting... Dec 06 00:30:05 marty go-librespot[10259]: time="2025-12-06T00:30:05+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:05 marty go-librespot[10259]: time="2025-12-06T00:30:05+01:00" level=debug msg="app state loaded" Dec 06 00:30:05 marty go-librespot[10259]: time="2025-12-06T00:30:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:05 marty go-librespot[10259]: time="2025-12-06T00:30:05+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:05 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:05 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:07 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:07 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:08 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3073. Dec 06 00:30:08 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:08 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:08 marty go-librespot[10265]: go-librespot daemon starting... Dec 06 00:30:08 marty go-librespot[10266]: time="2025-12-06T00:30:08+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:08 marty go-librespot[10266]: time="2025-12-06T00:30:08+01:00" level=debug msg="app state loaded" Dec 06 00:30:08 marty go-librespot[10266]: time="2025-12-06T00:30:08+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:08 marty go-librespot[10266]: time="2025-12-06T00:30:08+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:08 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:08 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:10 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:10 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:11 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3074. Dec 06 00:30:11 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:11 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:11 marty go-librespot[10276]: go-librespot daemon starting... Dec 06 00:30:12 marty go-librespot[10277]: time="2025-12-06T00:30:12+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:12 marty go-librespot[10277]: time="2025-12-06T00:30:12+01:00" level=debug msg="app state loaded" Dec 06 00:30:12 marty go-librespot[10277]: time="2025-12-06T00:30:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:12 marty go-librespot[10277]: time="2025-12-06T00:30:12+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:12 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:12 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:13 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:13 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:15 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3075. Dec 06 00:30:15 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:15 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:15 marty go-librespot[10299]: go-librespot daemon starting... Dec 06 00:30:15 marty go-librespot[10300]: time="2025-12-06T00:30:15+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:15 marty go-librespot[10300]: time="2025-12-06T00:30:15+01:00" level=debug msg="app state loaded" Dec 06 00:30:15 marty go-librespot[10300]: time="2025-12-06T00:30:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:15 marty go-librespot[10300]: time="2025-12-06T00:30:15+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:15 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:15 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:16 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:16 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:18 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3076. Dec 06 00:30:18 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:18 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:18 marty go-librespot[10306]: go-librespot daemon starting... Dec 06 00:30:18 marty go-librespot[10307]: time="2025-12-06T00:30:18+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:18 marty go-librespot[10307]: time="2025-12-06T00:30:18+01:00" level=debug msg="app state loaded" Dec 06 00:30:18 marty go-librespot[10307]: time="2025-12-06T00:30:18+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:18 marty go-librespot[10307]: time="2025-12-06T00:30:18+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:18 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:18 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:19 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:19 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:21 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3077. Dec 06 00:30:21 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:21 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:21 marty go-librespot[10313]: go-librespot daemon starting... Dec 06 00:30:21 marty go-librespot[10314]: time="2025-12-06T00:30:21+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:21 marty go-librespot[10314]: time="2025-12-06T00:30:21+01:00" level=debug msg="app state loaded" Dec 06 00:30:21 marty go-librespot[10314]: time="2025-12-06T00:30:21+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:21 marty go-librespot[10314]: time="2025-12-06T00:30:21+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:21 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:21 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:22 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:22 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:24 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3078. Dec 06 00:30:24 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:24 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:24 marty go-librespot[10334]: go-librespot daemon starting... Dec 06 00:30:25 marty go-librespot[10336]: time="2025-12-06T00:30:25+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:25 marty go-librespot[10336]: time="2025-12-06T00:30:25+01:00" level=debug msg="app state loaded" Dec 06 00:30:25 marty go-librespot[10336]: time="2025-12-06T00:30:25+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:25 marty go-librespot[10336]: time="2025-12-06T00:30:25+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Dec 06 00:30:25 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:25 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:25 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:25 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:26 marty systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 06 00:30:26 marty systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 06 00:30:26 marty systemd[1]: welcome.service: Deactivated successfully. Dec 06 00:30:26 marty systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 06 00:30:26 marty systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 06 00:30:26 marty systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 06 00:30:26 marty welcome[10364]: Resolved ip:[1] 192.168.2.122 Dec 06 00:30:26 marty systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 06 00:30:26 marty systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin bluetooth to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin multiroom to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin metavolumio to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin cd_controller to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 06 00:30:28 marty volumio[22046]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 06 00:30:28 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3079. Dec 06 00:30:28 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:28 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:28 marty go-librespot[10369]: go-librespot daemon starting... Dec 06 00:30:28 marty go-librespot[10370]: time="2025-12-06T00:30:28+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:28 marty go-librespot[10370]: time="2025-12-06T00:30:28+01:00" level=debug msg="app state loaded" Dec 06 00:30:28 marty go-librespot[10370]: time="2025-12-06T00:30:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:28 marty go-librespot[10370]: time="2025-12-06T00:30:28+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-06T00:30:28+01:00 is before 2025-12-08T00:00:00Z" Dec 06 00:30:28 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:28 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:30 marty volumio[22046]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 06 00:30:30 marty volumio[22046]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 06 00:30:30 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:30 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:30 marty volumio[22046]: info: Starting MyVolumio Remote Streaming Endpoints Dec 06 00:30:31 marty volumio[22046]: info: MyVolumio login type: Token Dec 06 00:30:31 marty volumio[22046]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 06 00:30:31 marty volumio[22046]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 06 00:30:32 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3080. Dec 06 00:30:32 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:32 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:32 marty go-librespot[10381]: go-librespot daemon starting... Dec 06 00:30:32 marty go-librespot[10382]: time="2025-12-06T00:30:32+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:32 marty go-librespot[10382]: time="2025-12-06T00:30:32+01:00" level=debug msg="app state loaded" Dec 06 00:30:32 marty go-librespot[10382]: time="2025-12-06T00:30:32+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:32 marty go-librespot[10382]: time="2025-12-06T00:30:32+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-06T00:30:32+01:00 is before 2025-12-08T00:00:00Z" Dec 06 00:30:32 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:32 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:33 marty volumio[22046]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 06 00:30:33 marty volumio[22046]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 06 00:30:33 marty volumio[22046]: info: Streaming services startup Dec 06 00:30:33 marty volumio[22046]: info: Starting Streaming Daemon Dec 06 00:30:33 marty sudo[10391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 06 00:30:33 marty volumio[22046]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 06 00:30:33 marty sudo[10391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 00:30:33 marty sudo[10391]: pam_unix(sudo:session): session closed for user root Dec 06 00:30:33 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:33 marty volumio[22046]: error: Cannot start Volumio Streaming Daemon Dec 06 00:30:33 marty volumio[22046]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 06 00:30:33 marty volumio[22046]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 06 00:30:33 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:34 marty volumio[22046]: error: MyVolumio Custom Token format not valid, refreshing it Dec 06 00:30:34 marty volumio[22046]: info: MyVolumio login type: Token Dec 06 00:30:35 marty volumio[22046]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 06 00:30:35 marty volumio[22046]: info: MyVolumio token set successfully Dec 06 00:30:35 marty volumio[22046]: info: MYVOLUMIO: Adding device Dec 06 00:30:35 marty volumio[22046]: info: MYVOLUMIO: Evaluating Server Dec 06 00:30:35 marty volumio[22046]: info: MyVolumio status changed Dec 06 00:30:35 marty volumio[22046]: info: Streaming services startup Dec 06 00:30:35 marty volumio[22046]: info: Starting Streaming Daemon Dec 06 00:30:35 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3081. Dec 06 00:30:35 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:35 marty volumio[22046]: info: Removing browser output: myVolumio user plan is not superstar Dec 06 00:30:35 marty volumio[22046]: info: Removing audio output: Dec 06 00:30:35 marty volumio[22046]: info: Stoppping Tunnel 1 Dec 06 00:30:35 marty sudo[10433]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 06 00:30:36 marty sudo[10433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 00:30:36 marty sudo[10436]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 06 00:30:36 marty sudo[10436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 06 00:30:36 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:36 marty go-librespot[10434]: go-librespot daemon starting... Dec 06 00:30:36 marty go-librespot[10439]: time="2025-12-06T00:30:36+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:36 marty go-librespot[10439]: time="2025-12-06T00:30:36+01:00" level=debug msg="app state loaded" Dec 06 00:30:36 marty go-librespot[10439]: time="2025-12-06T00:30:36+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:36 marty sudo[10433]: pam_unix(sudo:session): session closed for user root Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty volumio[22046]: error: Cannot start Volumio Streaming Daemon Dec 06 00:30:36 marty volumio[22046]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 06 00:30:36 marty volumio[22046]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty volumio[22046]: info: Setting Geolocation for MyVolumio to eu2 Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 06 00:30:36 marty sudo[10436]: pam_unix(sudo:session): session closed for user root Dec 06 00:30:36 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:36 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:36 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:36 marty volumio[22046]: info: Remote SSH Stopped Dec 06 00:30:36 marty go-librespot[10439]: time="2025-12-06T00:30:36+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-06T00:30:36+01:00 is before 2025-12-08T00:00:00Z" Dec 06 00:30:36 marty volumio[22046]: info: Successfully Added MyVolumio device Dec 06 00:30:36 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:36 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:36 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:36 marty volumio[22046]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:37 marty volumio[22046]: info: Updating MyVolumio device info Dec 06 00:30:37 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:37 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:37 marty volumio[22046]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 06 00:30:37 marty volumio[22046]: info: Successfully Updated MyVolumio device Dec 06 00:30:39 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3082. Dec 06 00:30:39 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:39 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:39 marty go-librespot[10446]: go-librespot daemon starting... Dec 06 00:30:39 marty go-librespot[10447]: time="2025-12-06T00:30:39+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:39 marty go-librespot[10447]: time="2025-12-06T00:30:39+01:00" level=debug msg="app state loaded" Dec 06 00:30:39 marty go-librespot[10447]: time="2025-12-06T00:30:39+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:39 marty volumio[22046]: info: Initializing connection to go-librespot Websocket Dec 06 00:30:39 marty go-librespot[10447]: time="2025-12-06T00:30:39+01:00" level=debug msg="new websocket client" Dec 06 00:30:39 marty volumio[22046]: info: Connection to go-librespot Websocket established Dec 06 00:30:40 marty go-librespot[10447]: time="2025-12-06T00:30:40+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-06T00:30:39+01:00 is before 2025-12-08T00:00:00Z" Dec 06 00:30:40 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:40 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:40 marty volumio[22046]: info: Connection to go-librespot Websocket closed Dec 06 00:30:42 marty volumio[22046]: info: Getting Spotify volume Dec 06 00:30:42 marty volumio[22046]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 00:30:42 marty volumio[22046]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 06 00:30:42 marty volumio[22046]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 06 00:30:42 marty volumio[22046]: errno: -111, Dec 06 00:30:42 marty volumio[22046]: code: 'ECONNREFUSED', Dec 06 00:30:42 marty volumio[22046]: syscall: 'connect', Dec 06 00:30:42 marty volumio[22046]: address: '127.0.0.1', Dec 06 00:30:42 marty volumio[22046]: port: 9879, Dec 06 00:30:42 marty volumio[22046]: response: undefined Dec 06 00:30:42 marty volumio[22046]: } Dec 06 00:30:42 marty volumio[22046]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 06 00:30:43 marty systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3083. Dec 06 00:30:43 marty systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:43 marty systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 06 00:30:43 marty go-librespot[10465]: go-librespot daemon starting... Dec 06 00:30:43 marty go-librespot[10467]: time="2025-12-06T00:30:43+01:00" level=info msg="running go-librespot 0.4.0" Dec 06 00:30:43 marty go-librespot[10467]: time="2025-12-06T00:30:43+01:00" level=debug msg="app state loaded" Dec 06 00:30:43 marty go-librespot[10467]: time="2025-12-06T00:30:43+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 06 00:30:43 marty go-librespot[10467]: time="2025-12-06T00:30:43+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-12-06T00:30:43+01:00 is before 2025-12-08T00:00:00Z" Dec 06 00:30:43 marty systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 06 00:30:43 marty systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 06 00:30:44 marty sudo[10477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 00:29' Dec 06 00:30:44 marty sudo[10477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"