Feb 24 07:49:02 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 73. Feb 24 07:49:02 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:02 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:02 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:02 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:02 volumio go-librespot[3031]: go-librespot daemon starting... Feb 24 07:49:02 volumio go-librespot[3032]: time="2026-02-24T07:49:02+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:02 volumio go-librespot[3032]: time="2026-02-24T07:49:02+01:00" level=debug msg="app state loaded" Feb 24 07:49:02 volumio go-librespot[3032]: time="2026-02-24T07:49:02+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:02 volumio go-librespot[3032]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:02 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:02 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:03 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:03 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:03 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:03 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:05 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:05 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:05 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 74. Feb 24 07:49:05 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:05 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:05 volumio go-librespot[3040]: go-librespot daemon starting... Feb 24 07:49:05 volumio go-librespot[3041]: time="2026-02-24T07:49:05+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:05 volumio go-librespot[3041]: time="2026-02-24T07:49:05+01:00" level=debug msg="app state loaded" Feb 24 07:49:05 volumio go-librespot[3041]: time="2026-02-24T07:49:05+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:05 volumio go-librespot[3041]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:08 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:08 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:09 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 75. Feb 24 07:49:09 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:09 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:09 volumio go-librespot[3063]: go-librespot daemon starting... Feb 24 07:49:09 volumio go-librespot[3064]: time="2026-02-24T07:49:09+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:09 volumio go-librespot[3064]: time="2026-02-24T07:49:09+01:00" level=debug msg="app state loaded" Feb 24 07:49:09 volumio go-librespot[3064]: time="2026-02-24T07:49:09+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:09 volumio go-librespot[3064]: time="2026-02-24T07:49:09+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:09 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:09 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:11 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:11 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:12 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 76. Feb 24 07:49:12 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:12 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:12 volumio go-librespot[3073]: go-librespot daemon starting... Feb 24 07:49:12 volumio go-librespot[3074]: time="2026-02-24T07:49:12+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:12 volumio go-librespot[3074]: time="2026-02-24T07:49:12+01:00" level=debug msg="app state loaded" Feb 24 07:49:12 volumio go-librespot[3074]: time="2026-02-24T07:49:12+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:12 volumio go-librespot[3074]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:12 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:12 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:13 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:13 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:14 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:14 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:15 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 77. Feb 24 07:49:15 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:15 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:15 volumio go-librespot[3082]: go-librespot daemon starting... Feb 24 07:49:15 volumio go-librespot[3083]: time="2026-02-24T07:49:15+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:15 volumio go-librespot[3083]: time="2026-02-24T07:49:15+01:00" level=debug msg="app state loaded" Feb 24 07:49:15 volumio go-librespot[3083]: time="2026-02-24T07:49:15+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:15 volumio go-librespot[3083]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:17 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:17 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:18 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 78. Feb 24 07:49:18 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:18 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:18 volumio go-librespot[3092]: go-librespot daemon starting... Feb 24 07:49:18 volumio go-librespot[3107]: time="2026-02-24T07:49:18+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:18 volumio go-librespot[3107]: time="2026-02-24T07:49:18+01:00" level=debug msg="app state loaded" Feb 24 07:49:18 volumio go-librespot[3107]: time="2026-02-24T07:49:18+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:18 volumio go-librespot[3107]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:18 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:18 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:20 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:20 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:22 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 79. Feb 24 07:49:22 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:22 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:22 volumio go-librespot[3115]: go-librespot daemon starting... Feb 24 07:49:22 volumio go-librespot[3116]: time="2026-02-24T07:49:22+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:22 volumio go-librespot[3116]: time="2026-02-24T07:49:22+01:00" level=debug msg="app state loaded" Feb 24 07:49:22 volumio go-librespot[3116]: time="2026-02-24T07:49:22+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:22 volumio go-librespot[3116]: time="2026-02-24T07:49:22+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:22 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:22 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:23 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:23 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:23 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:23 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:23 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:23 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:25 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 80. Feb 24 07:49:25 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:25 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:25 volumio go-librespot[3125]: go-librespot daemon starting... Feb 24 07:49:25 volumio go-librespot[3126]: time="2026-02-24T07:49:25+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:25 volumio go-librespot[3126]: time="2026-02-24T07:49:25+01:00" level=debug msg="app state loaded" Feb 24 07:49:25 volumio go-librespot[3126]: time="2026-02-24T07:49:25+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:25 volumio go-librespot[3126]: time="2026-02-24T07:49: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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:25 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:25 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:26 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:26 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:28 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 81. Feb 24 07:49:28 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:28 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:28 volumio go-librespot[3134]: go-librespot daemon starting... Feb 24 07:49:28 volumio go-librespot[3135]: time="2026-02-24T07:49:28+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:28 volumio go-librespot[3135]: time="2026-02-24T07:49:28+01:00" level=debug msg="app state loaded" Feb 24 07:49:28 volumio go-librespot[3135]: time="2026-02-24T07:49:28+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:28 volumio go-librespot[3135]: time="2026-02-24T07:49: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\": dial tcp 0.0.0.0:443: connect: connection refused" Feb 24 07:49:28 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:28 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:29 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:29 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:31 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 82. Feb 24 07:49:31 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:31 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:31 volumio go-librespot[3157]: go-librespot daemon starting... Feb 24 07:49:31 volumio go-librespot[3158]: time="2026-02-24T07:49:31+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:31 volumio go-librespot[3158]: time="2026-02-24T07:49:31+01:00" level=debug msg="app state loaded" Feb 24 07:49:31 volumio go-librespot[3158]: time="2026-02-24T07:49:31+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:31 volumio go-librespot[3158]: time="2026-02-24T07:49:31+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:31 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:31 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:32 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:32 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:33 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:33 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:35 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 83. Feb 24 07:49:35 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:35 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:35 volumio go-librespot[3166]: go-librespot daemon starting... Feb 24 07:49:35 volumio go-librespot[3167]: time="2026-02-24T07:49:35+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:35 volumio go-librespot[3167]: time="2026-02-24T07:49:35+01:00" level=debug msg="app state loaded" Feb 24 07:49:35 volumio go-librespot[3167]: time="2026-02-24T07:49:35+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:35 volumio go-librespot[3167]: time="2026-02-24T07:49:35+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:35 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:35 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:35 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:35 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:38 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 84. Feb 24 07:49:38 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:38 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:38 volumio go-librespot[3177]: go-librespot daemon starting... Feb 24 07:49:38 volumio go-librespot[3178]: time="2026-02-24T07:49:38+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:38 volumio go-librespot[3178]: time="2026-02-24T07:49:38+01:00" level=debug msg="app state loaded" Feb 24 07:49:38 volumio go-librespot[3178]: time="2026-02-24T07:49:38+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:38 volumio go-librespot[3178]: time="2026-02-24T07:49:38+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp 0.0.0.0:443: connect: connection refused" Feb 24 07:49:38 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:38 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:38 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:38 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:41 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 85. Feb 24 07:49:41 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:41 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:41 volumio go-librespot[3201]: go-librespot daemon starting... Feb 24 07:49:41 volumio go-librespot[3202]: time="2026-02-24T07:49:41+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:41 volumio go-librespot[3202]: time="2026-02-24T07:49:41+01:00" level=debug msg="app state loaded" Feb 24 07:49:41 volumio go-librespot[3202]: time="2026-02-24T07:49:41+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:41 volumio go-librespot[3202]: time="2026-02-24T07:49:41+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:41 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:41 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:41 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:41 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:43 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:43 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:43 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:43 volumio volumio[1267]: info: Listing playlists Feb 24 07:49:44 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:44 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:44 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 86. Feb 24 07:49:44 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:44 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:44 volumio go-librespot[3210]: go-librespot daemon starting... Feb 24 07:49:44 volumio go-librespot[3211]: time="2026-02-24T07:49:44+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:44 volumio go-librespot[3211]: time="2026-02-24T07:49:44+01:00" level=debug msg="app state loaded" Feb 24 07:49:44 volumio go-librespot[3211]: time="2026-02-24T07:49:44+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:44 volumio go-librespot[3211]: time="2026-02-24T07:49:44+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:44 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:44 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:47 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:47 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:48 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 87. Feb 24 07:49:48 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:48 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:48 volumio go-librespot[3219]: go-librespot daemon starting... Feb 24 07:49:48 volumio go-librespot[3220]: time="2026-02-24T07:49:48+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:48 volumio go-librespot[3220]: time="2026-02-24T07:49:48+01:00" level=debug msg="app state loaded" Feb 24 07:49:48 volumio go-librespot[3220]: time="2026-02-24T07:49:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:48 volumio go-librespot[3220]: time="2026-02-24T07:49:48+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:50 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:50 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:51 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 88. Feb 24 07:49:51 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:51 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:51 volumio go-librespot[3242]: go-librespot daemon starting... Feb 24 07:49:51 volumio go-librespot[3243]: time="2026-02-24T07:49:51+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:51 volumio go-librespot[3243]: time="2026-02-24T07:49:51+01:00" level=debug msg="app state loaded" Feb 24 07:49:51 volumio go-librespot[3243]: time="2026-02-24T07:49:51+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:51 volumio go-librespot[3243]: time="2026-02-24T07:49:51+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:51 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:51 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:53 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:49:53 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:49:53 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:53 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:54 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 89. Feb 24 07:49:54 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:54 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:54 volumio go-librespot[3251]: go-librespot daemon starting... Feb 24 07:49:54 volumio go-librespot[3252]: time="2026-02-24T07:49:54+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:54 volumio go-librespot[3252]: time="2026-02-24T07:49:54+01:00" level=debug msg="app state loaded" Feb 24 07:49:54 volumio go-librespot[3252]: time="2026-02-24T07:49:54+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:54 volumio go-librespot[3252]: time="2026-02-24T07:49:54+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:54 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:56 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:56 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:49:57 volumio sudo[3260]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/nano /home/volumio/boot_tasks.sh Feb 24 07:49:57 volumio sudo[3260]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Feb 24 07:49:57 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 90. Feb 24 07:49:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:49:57 volumio go-librespot[3264]: go-librespot daemon starting... Feb 24 07:49:57 volumio go-librespot[3265]: time="2026-02-24T07:49:57+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:49:57 volumio go-librespot[3265]: time="2026-02-24T07:49:57+01:00" level=debug msg="app state loaded" Feb 24 07:49:57 volumio go-librespot[3265]: time="2026-02-24T07:49:57+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:49:57 volumio go-librespot[3265]: time="2026-02-24T07:49:57+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 0.0.0.0:443: connect: connection refused" Feb 24 07:49:57 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:49:57 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:49:59 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:49:59 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:01 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 91. Feb 24 07:50:01 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:01 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:01 volumio go-librespot[3287]: go-librespot daemon starting... Feb 24 07:50:01 volumio go-librespot[3288]: time="2026-02-24T07:50:01+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:01 volumio go-librespot[3288]: time="2026-02-24T07:50:01+01:00" level=debug msg="app state loaded" Feb 24 07:50:01 volumio go-librespot[3288]: time="2026-02-24T07:50:01+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:01 volumio go-librespot[3288]: time="2026-02-24T07:50:01+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:01 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:01 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:02 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:02 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:03 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:03 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:03 volumio volumio[1267]: info: Listing playlists Feb 24 07:50:03 volumio volumio[1267]: info: Listing playlists Feb 24 07:50:03 volumio sudo[3260]: pam_unix(sudo:session): session closed for user root Feb 24 07:50:04 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 92. Feb 24 07:50:04 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:04 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:04 volumio go-librespot[3296]: go-librespot daemon starting... Feb 24 07:50:04 volumio go-librespot[3297]: time="2026-02-24T07:50:04+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:04 volumio go-librespot[3297]: time="2026-02-24T07:50:04+01:00" level=debug msg="app state loaded" Feb 24 07:50:04 volumio go-librespot[3297]: time="2026-02-24T07:50:04+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:04 volumio go-librespot[3297]: time="2026-02-24T07:50:04+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:05 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:05 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Feb 24 07:50:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:07 volumio go-librespot[3305]: go-librespot daemon starting... Feb 24 07:50:07 volumio go-librespot[3306]: time="2026-02-24T07:50:07+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:07 volumio go-librespot[3306]: time="2026-02-24T07:50:07+01:00" level=debug msg="app state loaded" Feb 24 07:50:07 volumio go-librespot[3306]: time="2026-02-24T07:50:07+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:07 volumio go-librespot[3306]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:07 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:07 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:08 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:08 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:10 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 94. Feb 24 07:50:10 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:10 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:10 volumio go-librespot[3333]: go-librespot daemon starting... Feb 24 07:50:10 volumio go-librespot[3334]: time="2026-02-24T07:50:10+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:10 volumio go-librespot[3334]: time="2026-02-24T07:50:10+01:00" level=debug msg="app state loaded" Feb 24 07:50:10 volumio go-librespot[3334]: time="2026-02-24T07:50:10+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:10 volumio go-librespot[3334]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:10 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:10 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:11 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:11 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:13 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:13 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:14 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Feb 24 07:50:14 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:14 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:14 volumio go-librespot[3343]: go-librespot daemon starting... Feb 24 07:50:14 volumio go-librespot[3344]: time="2026-02-24T07:50:14+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:14 volumio go-librespot[3344]: time="2026-02-24T07:50:14+01:00" level=debug msg="app state loaded" Feb 24 07:50:14 volumio go-librespot[3344]: time="2026-02-24T07:50:14+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:14 volumio go-librespot[3344]: time="2026-02-24T07:50:14+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:14 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:14 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:14 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:14 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:17 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Feb 24 07:50:17 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:17 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:17 volumio go-librespot[3353]: go-librespot daemon starting... Feb 24 07:50:17 volumio go-librespot[3354]: time="2026-02-24T07:50:17+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:17 volumio go-librespot[3354]: time="2026-02-24T07:50:17+01:00" level=debug msg="app state loaded" Feb 24 07:50:17 volumio go-librespot[3354]: time="2026-02-24T07:50:17+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:17 volumio go-librespot[3354]: time="2026-02-24T07:50:17+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:17 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:17 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 97. Feb 24 07:50:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:20 volumio go-librespot[3376]: go-librespot daemon starting... Feb 24 07:50:20 volumio go-librespot[3377]: time="2026-02-24T07:50:20+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:20 volumio go-librespot[3377]: time="2026-02-24T07:50:20+01:00" level=debug msg="app state loaded" Feb 24 07:50:20 volumio go-librespot[3377]: time="2026-02-24T07:50:20+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:20 volumio go-librespot[3377]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:20 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:20 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:20 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:20 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:23 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:23 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:23 volumio volumio[1267]: info: Listing playlists Feb 24 07:50:23 volumio volumio[1267]: info: Listing playlists Feb 24 07:50:23 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:23 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:23 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 98. Feb 24 07:50:23 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:23 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:23 volumio go-librespot[3385]: go-librespot daemon starting... Feb 24 07:50:23 volumio go-librespot[3386]: time="2026-02-24T07:50:23+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:23 volumio go-librespot[3386]: time="2026-02-24T07:50:23+01:00" level=debug msg="app state loaded" Feb 24 07:50:23 volumio go-librespot[3386]: time="2026-02-24T07:50:23+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:23 volumio go-librespot[3386]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:23 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:23 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:26 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:26 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:27 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 99. Feb 24 07:50:27 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:27 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:27 volumio go-librespot[3396]: go-librespot daemon starting... Feb 24 07:50:27 volumio go-librespot[3397]: time="2026-02-24T07:50:27+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:27 volumio go-librespot[3397]: time="2026-02-24T07:50:27+01:00" level=debug msg="app state loaded" Feb 24 07:50:27 volumio go-librespot[3397]: time="2026-02-24T07:50:27+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:27 volumio go-librespot[3397]: time="2026-02-24T07:50:27+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:27 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:27 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:29 volumio sudo[3420]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/chown volumio:volumio boot_tasks.sh Feb 24 07:50:29 volumio sudo[3420]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Feb 24 07:50:29 volumio sudo[3420]: pam_unix(sudo:session): session closed for user root Feb 24 07:50:29 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:29 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:30 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 100. Feb 24 07:50:30 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:30 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:30 volumio go-librespot[3423]: go-librespot daemon starting... Feb 24 07:50:30 volumio go-librespot[3424]: time="2026-02-24T07:50:30+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:30 volumio go-librespot[3424]: time="2026-02-24T07:50:30+01:00" level=debug msg="app state loaded" Feb 24 07:50:30 volumio go-librespot[3424]: time="2026-02-24T07:50:30+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:30 volumio go-librespot[3424]: time="2026-02-24T07:50:30+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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:30 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:30 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:32 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:32 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:33 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:33 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:33 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 101. Feb 24 07:50:33 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:33 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:33 volumio go-librespot[3434]: go-librespot daemon starting... Feb 24 07:50:33 volumio go-librespot[3435]: time="2026-02-24T07:50:33+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:33 volumio go-librespot[3435]: time="2026-02-24T07:50:33+01:00" level=debug msg="app state loaded" Feb 24 07:50:33 volumio go-librespot[3435]: time="2026-02-24T07:50:33+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:33 volumio go-librespot[3435]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:33 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:33 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:35 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:35 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:36 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 102. Feb 24 07:50:36 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:36 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:36 volumio go-librespot[3443]: go-librespot daemon starting... Feb 24 07:50:36 volumio go-librespot[3444]: time="2026-02-24T07:50:36+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:36 volumio go-librespot[3444]: time="2026-02-24T07:50:36+01:00" level=debug msg="app state loaded" Feb 24 07:50:36 volumio go-librespot[3444]: time="2026-02-24T07:50:36+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:36 volumio go-librespot[3444]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:36 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:36 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:38 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:38 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:40 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 103. Feb 24 07:50:40 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:40 volumio go-librespot[3467]: go-librespot daemon starting... Feb 24 07:50:40 volumio go-librespot[3468]: time="2026-02-24T07:50:40+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:40 volumio go-librespot[3468]: time="2026-02-24T07:50:40+01:00" level=debug msg="app state loaded" Feb 24 07:50:40 volumio go-librespot[3468]: time="2026-02-24T07:50:40+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:40 volumio go-librespot[3468]: time="2026-02-24T07:50: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\": dial tcp 0.0.0.0:443: connect: connection refused" Feb 24 07:50:40 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:40 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:41 volumio sudo[3476]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl restart enable-wifi.service Feb 24 07:50:41 volumio sudo[3476]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Feb 24 07:50:41 volumio systemd[1]: Starting enable-wifi.service - Enable wifi workaround... Feb 24 07:50:41 volumio sudo[3481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm /run/wpa_supplicant/wlan0 Feb 24 07:50:41 volumio sudo[3481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 07:50:41 volumio sudo[3481]: pam_unix(sudo:session): session closed for user root Feb 24 07:50:41 volumio sudo[3483]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart networking Feb 24 07:50:41 volumio sudo[3483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 24 07:50:41 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:41 volumio volumio[1267]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 07:50:41 volumio systemd[1]: Stopping networking.service - Raise network interfaces... Feb 24 07:50:41 volumio ifdown[3496]: RTNETLINK answers: No such process Feb 24 07:50:41 volumio ifdown[3498]: Error: ipv4: Address not found. Feb 24 07:50:42 volumio ifdown[3516]: sending signal ALRM to pid 655 Feb 24 07:50:42 volumio ifdown[3516]: waiting for pid 655 to exit Feb 24 07:50:42 volumio dhcpcd[3516]: sending signal ALRM to pid 655 Feb 24 07:50:42 volumio dhcpcd[3516]: waiting for pid 655 to exit Feb 24 07:50:42 volumio dhcpcd[656]: received SIGALRM, releasing Feb 24 07:50:42 volumio dhcpcd[656]: eth0: removing interface Feb 24 07:50:42 volumio dhcpcd[656]: eth0: releasing lease of 10.20.30.22 Feb 24 07:50:42 volumio avahi-daemon[679]: Withdrawing address record for 10.20.30.22 on eth0. Feb 24 07:50:42 volumio avahi-daemon[679]: Leaving mDNS multicast group on interface eth0.IPv4 with address 10.20.30.22. Feb 24 07:50:42 volumio avahi-daemon[679]: Interface eth0.IPv4 no longer relevant for mDNS. Feb 24 07:50:42 volumio dhcpcd[769]: eth0: pid 656 deleted IP address 10.20.30.22/24 Feb 24 07:50:42 volumio dhcpcd[769]: eth0: deleting route to 10.20.30.0/24 Feb 24 07:50:42 volumio dhcpcd[769]: eth0: deleting default route via 10.20.30.254 Feb 24 07:50:42 volumio dhcpcd[656]: eth0: deleting route to 10.20.30.0/24 Feb 24 07:50:42 volumio dhcpcd[656]: eth0: deleting default route via 10.20.30.254 Feb 24 07:50:42 volumio volumio[1267]: info: Discovery: A device disappeared from network Feb 24 07:50:42 volumio volumio[1267]: info: Discovery: Device volumio disappeared from network Feb 24 07:50:42 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Feb 24 07:50:42 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Feb 24 07:50:42 volumio systemd[1]: welcome.service: Deactivated successfully. Feb 24 07:50:42 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 24 07:50:42 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 24 07:50:42 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 24 07:50:42 volumio welcome[3541]: Resolved ip:[0] Feb 24 07:50:42 volumio dhcpcd[769]: eth0: soliciting a DHCP lease Feb 24 07:50:42 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 24 07:50:42 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Feb 24 07:50:42 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Feb 24 07:50:42 volumio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Feb 24 07:50:42 volumio dhcpcd[769]: eth0: carrier lost Feb 24 07:50:42 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:43 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:43 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:43 volumio volumio5-onboarding[1492]: time=2026-02-24T07:50:43.014+01:00 level=INFO msg="enabling BLE discovery" Feb 24 07:50:43 volumio systemd[1]: networking.service: Deactivated successfully. Feb 24 07:50:43 volumio systemd[1]: Stopped networking.service - Raise network interfaces. Feb 24 07:50:43 volumio systemd[1]: Starting networking.service - Raise network interfaces... Feb 24 07:50:43 volumio wpa_supplicant[3615]: Successfully initialized wpa_supplicant Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: kernel reports: Match already configured Feb 24 07:50:43 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Feb 24 07:50:43 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 104. Feb 24 07:50:43 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:43 volumio wpa_supplicant[3615]: Failed to create interface p2p-dev-wlan0: -16 (Device or resource busy) Feb 24 07:50:43 volumio wpa_supplicant[3615]: nl80211: Failed to create a P2P Device interface p2p-dev-wlan0 Feb 24 07:50:43 volumio wpa_supplicant[3615]: P2P: Failed to enable P2P Device interface Feb 24 07:50:43 volumio kernel: ieee80211 phy0: brcmf_cfg80211_add_iface: iface validation failed: err=-16 Feb 24 07:50:43 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:43 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:43 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:43 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:43 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 07:50:43 volumio go-librespot[3617]: go-librespot daemon starting... Feb 24 07:50:43 volumio go-librespot[3631]: time="2026-02-24T07:50:43+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 07:50:43 volumio go-librespot[3631]: time="2026-02-24T07:50:43+01:00" level=debug msg="app state loaded" Feb 24 07:50:43 volumio avahi-daemon[679]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.20.30.250. Feb 24 07:50:43 volumio go-librespot[3631]: time="2026-02-24T07:50:43+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 07:50:43 volumio avahi-daemon[679]: New relevant interface wlan0.IPv4 for mDNS. Feb 24 07:50:43 volumio avahi-daemon[679]: Registering new address record for 10.20.30.250 on wlan0.IPv4. Feb 24 07:50:43 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 24 07:50:43 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Feb 24 07:50:43 volumio systemd[1]: welcome.service: Deactivated successfully. Feb 24 07:50:43 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 24 07:50:43 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 24 07:50:43 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 24 07:50:43 volumio kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Feb 24 07:50:43 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Down Feb 24 07:50:43 volumio ifplugd(eth0)[1026]: Link beat lost. Feb 24 07:50:43 volumio welcome[3645]: Resolved ip:[1] 10.20.30.250 Feb 24 07:50:43 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 24 07:50:43 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 24 07:50:43 volumio sh[3736]: sending commands to dhcpcd process Feb 24 07:50:43 volumio dhcpcd[769]: control command: dhcpcd eth0 Feb 24 07:50:44 volumio dhcpcd[769]: control_free: No such file or directory Feb 24 07:50:44 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:44 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:44 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:44 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:44 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:44 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:44 volumio wpa_supplicant[3618]: wlan0: Trying to associate with 74:ac:b9:6a:cf:39 (SSID='KWANON' freq=2462 MHz) Feb 24 07:50:44 volumio wpa_supplicant[3618]: FT: Invalid key management type (2) Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:44 volumio systemd[1]: Finished networking.service - Raise network interfaces. Feb 24 07:50:44 volumio sudo[3483]: pam_unix(sudo:session): session closed for user root Feb 24 07:50:44 volumio systemd[1]: Finished enable-wifi.service - Enable wifi workaround. Feb 24 07:50:44 volumio sudo[3476]: pam_unix(sudo:session): session closed for user root Feb 24 07:50:44 volumio wpa_supplicant[1247]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:44 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:44 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:44 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:44 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:44 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:44 volumio volumio[1267]: info: Initializing connection to go-librespot Websocket Feb 24 07:50:44 volumio go-librespot[3631]: time="2026-02-24T07:50:44+01:00" level=debug msg="new websocket client" Feb 24 07:50:44 volumio volumio[1267]: info: Connection to go-librespot Websocket established Feb 24 07:50:44 volumio dhcpcd[769]: eth0: carrier acquired Feb 24 07:50:44 volumio kernel: smsc95xx 1-1.1:1.0 eth0: Link is Up - 100Mbps/Full - flow control off Feb 24 07:50:44 volumio dhcpcd[769]: eth0: IAID eb:f8:b8:e3 Feb 24 07:50:44 volumio dhcpcd[769]: eth0: soliciting an IPv6 router Feb 24 07:50:45 volumio wpa_supplicant[3618]: wlan0: Trying to associate with 74:ac:b9:6a:cf:39 (SSID='KWANON' freq=2462 MHz) Feb 24 07:50:45 volumio wpa_supplicant[3618]: FT: Invalid key management type (2) Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:45 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:45 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:45 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:45 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:45 volumio wpa_supplicant[1247]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:45 volumio ifplugd(eth0)[1026]: Link beat detected. Feb 24 07:50:45 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:45 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:45 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:45 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:46 volumio ntpd[998]: IO: Deleting interface #3 eth0, 10.20.30.22#123, interface stats: received=141, sent=148, dropped=0, active_time=389 secs Feb 24 07:50:46 volumio ntpd[998]: PROTO: 129.152.16.145 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 172.232.208.229 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 212.45.144.206 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 151.22.209.90 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 5.249.149.252 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 217.61.62.224 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 185.157.229.254 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 188.217.191.74 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 162.159.200.1 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 93.94.88.51 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 212.6.50.243 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 185.19.184.35 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio ntpd[998]: PROTO: 93.94.88.50 unlink local addr 10.20.30.22 -> Feb 24 07:50:46 volumio wpa_supplicant[3618]: wlan0: Trying to associate with 74:ac:b9:6a:cf:39 (SSID='KWANON' freq=2462 MHz) Feb 24 07:50:46 volumio wpa_supplicant[3618]: FT: Invalid key management type (2) Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:46 volumio dhcpcd[769]: eth0: soliciting a DHCP lease Feb 24 07:50:46 volumio dhcpcd[769]: eth0: offered 10.20.30.22 from 10.20.30.254 Feb 24 07:50:46 volumio dhcpcd[769]: eth0: probing address 10.20.30.22/24 Feb 24 07:50:46 volumio wpa_supplicant[1247]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:46 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Feb 24 07:50:47 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:47 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:47 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:47 volumio volumio[1267]: info: Getting Spotify volume Feb 24 07:50:47 volumio volumio[1267]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:47 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:47 volumio volumio[1267]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 24 07:50:47 volumio volumio[1267]: SPOTIFY: SPOTIFY VOLUME undefined Feb 24 07:50:47 volumio volumio[1267]: SPOTIFY: VOLUMIO VOLUME 100 Feb 24 07:50:47 volumio volumio[1267]: info: Aligning Spotify Volume to Volumio Volume Feb 24 07:50:47 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:47 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:47 volumio volumio[1267]: info: Setting Spotify Volume from Volumio: 100 Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: Trying to associate with 74:ac:b9:6a:cf:39 (SSID='KWANON' freq=2462 MHz) Feb 24 07:50:48 volumio wpa_supplicant[3618]: FT: Invalid key management type (2) Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: nl80211: kernel reports: Match already configured Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: Associated with 74:ac:b9:6a:cf:39 Feb 24 07:50:48 volumio wpa_supplicant[1247]: Ignore unexpected EVENT_ASSOC in disconnected state Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 24 07:50:48 volumio wpa_supplicant[1247]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=IT Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=IT Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: WPA: Key negotiation completed with 74:ac:b9:6a:cf:39 [PTK=CCMP GTK=CCMP] Feb 24 07:50:48 volumio wpa_supplicant[3618]: wlan0: CTRL-EVENT-CONNECTED - Connection to 74:ac:b9:6a:cf:39 completed [id=0 id_str=] Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: carrier acquired Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: connected to Access Point: KWANON Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: IAID eb:ad:ed:b6 Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: adding address fe80::9b:cfa4:a617:6eaa Feb 24 07:50:48 volumio dhcpcd[769]: ipv6_addaddr1: Permission denied Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: using static address 10.20.30.250/24 Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: adding route to 10.20.30.0/24 Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: adding default route via 10.20.30.254 Feb 24 07:50:48 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 24 07:50:48 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Feb 24 07:50:48 volumio systemd[1]: welcome.service: Deactivated successfully. Feb 24 07:50:48 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 24 07:50:48 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 24 07:50:48 volumio dhcpcd[769]: wlan0: soliciting an IPv6 router Feb 24 07:50:48 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 24 07:50:48 volumio welcome[3816]: Resolved ip:[1] 10.20.30.250 Feb 24 07:50:48 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 24 07:50:48 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 24 07:50:49 volumio volumio[1267]: info: Volumio Network Manager: Network status updated: 2 Feb 24 07:50:49 volumio volumio[1267]: info: Received Get System Info Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 24 07:50:49 volumio volumio[1267]: info: Discovery: Getting this device information Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:49 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 24 07:50:49 volumio volumio[1267]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Feb 24 07:50:49 volumio volumio[1267]: info: Sending Spotify command with payload to local API: /player/volume Feb 24 07:50:49 volumio go-librespot[3631]: time="2026-02-24T07:50: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 0.0.0.0:443: connect: connection refused" Feb 24 07:50:49 volumio volumio[1267]: info: Discovery: adding 11eb34aa-faa6-4475-9229-7ad9e8a7e7ac Feb 24 07:50:49 volumio volumio[1267]: info: Discovery: Found device Volumio Feb 24 07:50:49 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 24 07:50:49 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 07:50:49 volumio volumio[1267]: info: CoreCommandRouter::volumioGetState Feb 24 07:50:49 volumio volumio[1267]: info: CorePlayQueue::getTrack 0 Feb 24 07:50:49 volumio volumio[1267]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Feb 24 07:50:49 volumio volumio[1267]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 07:50:49 volumio volumio[1267]: Error: socket hang up Feb 24 07:50:49 volumio volumio[1267]: at connResetException (node:internal/errors:720:14) Feb 24 07:50:49 volumio volumio[1267]: at Socket.socketOnEnd (node:_http_client:519:23) Feb 24 07:50:49 volumio volumio[1267]: at Socket.emit (node:events:526:35) Feb 24 07:50:49 volumio volumio[1267]: at endReadableNT (node:internal/streams/readable:1376:12) Feb 24 07:50:49 volumio volumio[1267]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Feb 24 07:50:49 volumio volumio[1267]: code: 'ECONNRESET', Feb 24 07:50:49 volumio volumio[1267]: response: undefined Feb 24 07:50:49 volumio volumio[1267]: } Feb 24 07:50:49 volumio volumio[1267]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 07:50:50 volumio ntpd[998]: IO: Listen normally on 4 wlan0 10.20.30.250:123 Feb 24 07:50:50 volumio ntpd[998]: IO: new interface(s) found: waking up resolver Feb 24 07:50:50 volumio sudo[3850]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 07:49' Feb 24 07:50:50 volumio sudo[3850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"