Dec 06 11:42:05 volumio---sp-sala go-librespot[2598]: time="2025-12-06T11:42:05-03: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 11:42:05 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:05 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:42:08 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1.
Dec 06 11:42:08 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:08 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:08 volumio---sp-sala go-librespot[2711]: go-librespot daemon starting...
Dec 06 11:42:08 volumio---sp-sala go-librespot[2712]: time="2025-12-06T11:42:08-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:42:08 volumio---sp-sala go-librespot[2712]: time="2025-12-06T11:42:08-03:00" level=debug msg="app state loaded"
Dec 06 11:42:08 volumio---sp-sala go-librespot[2712]: time="2025-12-06T11:42:08-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: Discovery: adding 9d15e54e-f811-482c-8e73-7a3cccc9d314
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: Discovery: Found device Volumio - SP Sala
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::volumioGetState
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: CorePlayQueue::getTrack 0
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: error: MyVolumio Plugin failed to start in a timely fashion
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: [Metrics] CommandRouter: 40s 574.75ms
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::volumiosetStartupVolume
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 06 11:42:11 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 11:42:12 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::Close All Modals sent
Dec 06 11:42:12 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::Close All Modals sent
Dec 06 11:42:13 volumio---sp-sala go-librespot[2712]: time="2025-12-06T11:42:13-03: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-06T11:42:13-03:00 is before 2025-12-08T00:00:00Z"
Dec 06 11:42:13 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:13 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: Discovery: this is already registered, 9d15e54e-f811-482c-8e73-7a3cccc9d314
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: Discovery: Found device Volumio - SP Sala
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::volumioGetState
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CorePlayQueue::getTrack 0
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Dec 06 11:42:14 volumio---sp-sala ntpd[1052]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101
Dec 06 11:42:14 volumio---sp-sala ntpd[1052]: DNS: dns_check: DNS error: -11, System error
Dec 06 11:42:14 volumio---sp-sala ntpd[1052]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Dec 06 11:42:14 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: Pool taking: 192.36.143.130
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: Pool taking: 200.160.7.196
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: Pool taking: 168.181.126.28
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: Pool taking: 143.107.229.210
Dec 06 11:42:15 volumio---sp-sala ntpd[1052]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8
Dec 06 11:42:15 volumio---sp-sala volumio[2311]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Dec 06 11:42:15 volumio---sp-sala volumio[2311]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for C1
Dec 06 11:42:15 volumio---sp-sala volumio[2311]: aplay: main:831: audio open error: No such device
Dec 06 11:42:16 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2.
Dec 06 11:42:16 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:16 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:16 volumio---sp-sala go-librespot[2771]: go-librespot daemon starting...
Dec 06 11:42:16 volumio---sp-sala go-librespot[2772]: time="2025-12-06T11:42:16-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:42:16 volumio---sp-sala go-librespot[2772]: time="2025-12-06T11:42:16-03:00" level=debug msg="app state loaded"
Dec 06 11:42:16 volumio---sp-sala go-librespot[2772]: time="2025-12-06T11:42:16-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:42:17 volumio---sp-sala go-librespot[2772]: time="2025-12-06T11:42:17-03: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-06T11:42:16-03:00 is before 2025-12-08T00:00:00Z"
Dec 06 11:42:17 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:17 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:42:17 volumio---sp-sala volumio[2311]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Dec 06 11:42:18 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 06 11:42:18 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 06 11:42:18 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: Received Get System Info
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: Discovery: Getting this device information
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::volumioGetState
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CorePlayQueue::getTrack 0
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=4.071&uuid=70732f6612aeaac3ad556c046a5b1bb8" http://updates.volumio.org/downloader-v1/track-device
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: % Total % Received % Xferd Average Speed Time Time Time Current
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: Dload Upload Total Spent Left Speed
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: [1.6K blob data]
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: retrying in 5 seconds, trial 0
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: Volumio Calling Home
Dec 06 11:42:19 volumio---sp-sala volumio[2311]: info: BOOT COMPLETED
Dec 06 11:42:20 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:20 volumio---sp-sala go-librespot[2786]: go-librespot daemon starting...
Dec 06 11:42:20 volumio---sp-sala go-librespot[2787]: time="2025-12-06T11:42:20-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:42:20 volumio---sp-sala go-librespot[2787]: time="2025-12-06T11:42:20-03:00" level=debug msg="app state loaded"
Dec 06 11:42:20 volumio---sp-sala go-librespot[2787]: time="2025-12-06T11:42:20-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:42:20 volumio---sp-sala volumio[2311]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Dec 06 11:42:20 volumio---sp-sala dhcpcd[708]: eth0: offered 192.168.15.17 from 192.168.15.1
Dec 06 11:42:20 volumio---sp-sala dhcpcd[708]: eth0: leased 192.168.15.17 for 7200 seconds
Dec 06 11:42:20 volumio---sp-sala dhcpcd[708]: eth0: adding route to 192.168.15.0/24
Dec 06 11:42:20 volumio---sp-sala dhcpcd[708]: eth0: adding default route via 192.168.15.1
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Dec 06 11:42:20 volumio---sp-sala systemd[1]: welcome.service: Deactivated successfully.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Stopped welcome.service - Show a welcome message on console.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Stopping welcome.service - Show a welcome message on console...
Dec 06 11:42:20 volumio---sp-sala go-librespot[2787]: time="2025-12-06T11:42:20-03: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-06T11:42:20-03:00 is before 2025-12-08T00:00:00Z"
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Starting welcome.service - Show a welcome message on console...
Dec 06 11:42:20 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:20 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:42:20 volumio---sp-sala welcome[2808]: Resolved ip:[2] 192.168.15.17 169.254.48.191
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Finished welcome.service - Show a welcome message on console.
Dec 06 11:42:20 volumio---sp-sala systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Dec 06 11:42:22 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Dec 06 11:42:22 volumio---sp-sala volumio[2311]: info: Initializing connection to go-librespot Websocket
Dec 06 11:42:23 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4.
Dec 06 11:42:23 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:23 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:23 volumio---sp-sala go-librespot[2826]: go-librespot daemon starting...
Dec 06 11:42:23 volumio---sp-sala go-librespot[2827]: time="2025-12-06T11:42:23-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:42:23 volumio---sp-sala go-librespot[2827]: time="2025-12-06T11:42:23-03:00" level=debug msg="app state loaded"
Dec 06 11:42:23 volumio---sp-sala go-librespot[2827]: time="2025-12-06T11:42:23-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:42:25 volumio---sp-sala go-librespot[2827]: time="2025-12-06T11:42:25-03: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-06T11:42:25-03:00 is before 2025-12-08T00:00:00Z"
Dec 06 11:42:25 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:25 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:42:27 volumio---sp-sala volumio[2311]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Dec 06 11:42:27 volumio---sp-sala volumio[2311]: SPOTIFY: BQDTVTd6Cv3_JeqmJ8hZQyFAlASP2MSLfSbcIsd3LXkvM7Ra6kiM-EUarVj3NXbqXuB81OxS-iHYj1KA6UwoEueBemXG1lV6sK_ouMOxpV6zuf5wfUFfE2iswGFVovEE8akqTO2T3DpE7hVb1GImx63gGQuevsqJXIsXm_YH3MaiAm0hgLvbvfcQhEfzV8HU3Fc1iy0W1hp8j6IMH-das8aND7RoI3fmzYsqAflpl5PYDXJmdf0OXdYy5ehBqLPvYByLPN0Wf9LsCr6gZ2dmXF1cpKPCsCGe1bqpCib8SIYgPoliZ15AjPOgH06_
Dec 06 11:42:27 volumio---sp-sala volumio[2311]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------
Dec 06 11:42:27 volumio---sp-sala volumio[2311]: info: New Spotify access token = BQDTVTd6Cv3_JeqmJ8hZQyFAlASP2MSLfSbcIsd3LXkvM7Ra6kiM-EUarVj3NXbqXuB81OxS-iHYj1KA6UwoEueBemXG1lV6sK_ouMOxpV6zuf5wfUFfE2iswGFVovEE8akqTO2T3DpE7hVb1GImx63gGQuevsqJXIsXm_YH3MaiAm0hgLvbvfcQhEfzV8HU3Fc1iy0W1hp8j6IMH-das8aND7RoI3fmzYsqAflpl5PYDXJmdf0OXdYy5ehBqLPvYByLPN0Wf9LsCr6gZ2dmXF1cpKPCsCGe1bqpCib8SIYgPoliZ15AjPOgH06_
Dec 06 11:42:27 volumio---sp-sala volumio[2311]: info: Spotify credentials grant success - running version from March 24, 2019
Dec 06 11:42:28 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 5.
Dec 06 11:42:28 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:28 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:42:28 volumio---sp-sala go-librespot[2850]: go-librespot daemon starting...
Dec 06 11:42:28 volumio---sp-sala go-librespot[2851]: time="2025-12-06T11:42:28-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:42:28 volumio---sp-sala go-librespot[2851]: time="2025-12-06T11:42:28-03:00" level=debug msg="app state loaded"
Dec 06 11:42:28 volumio---sp-sala go-librespot[2851]: time="2025-12-06T11:42:28-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:42:29 volumio---sp-sala volumio[2311]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 06 11:42:29 volumio---sp-sala volumio[2311]: info: Volumio called home
Dec 06 11:42:42 volumio---sp-sala volumio[2311]: info: Initializing connection to go-librespot Websocket
Dec 06 11:42:45 volumio---sp-sala dhcpcd[800]: eth0: failed to renew DHCP, rebinding
Dec 06 11:42:45 volumio---sp-sala dhcpcd[800]: eth0: leased 192.168.15.17 for 7200 seconds
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0.
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0...
Dec 06 11:42:45 volumio---sp-sala systemd[1]: welcome.service: Deactivated successfully.
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Stopped welcome.service - Show a welcome message on console.
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Stopping welcome.service - Show a welcome message on console...
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Starting welcome.service - Show a welcome message on console...
Dec 06 11:42:45 volumio---sp-sala welcome[2887]: Resolved ip:[2] 192.168.15.17 169.254.48.191
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Finished welcome.service - Show a welcome message on console.
Dec 06 11:42:45 volumio---sp-sala systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0.
Dec 06 11:42:45 volumio---sp-sala go-librespot[2851]: time="2025-12-06T11:42:45-03:00" level=debug msg="new websocket client"
Dec 06 11:42:47 volumio---sp-sala volumio[2311]: info: Connection to go-librespot Websocket established
Dec 06 11:42:58 volumio---sp-sala go-librespot[2851]: time="2025-12-06T11:42:58-03: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\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)"
Dec 06 11:42:58 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:42:58 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:43:00 volumio---sp-sala volumio[2311]: info: CoreCommandRouter::volumioGetState
Dec 06 11:43:00 volumio---sp-sala volumio[2311]: info: CorePlayQueue::getTrack 0
Dec 06 11:43:00 volumio---sp-sala volumio[2311]: info: Getting Spotify volume
Dec 06 11:43:01 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 6.
Dec 06 11:43:01 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:43:01 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:43:01 volumio---sp-sala go-librespot[2931]: go-librespot daemon starting...
Dec 06 11:43:01 volumio---sp-sala go-librespot[2932]: time="2025-12-06T11:43:01-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:43:01 volumio---sp-sala go-librespot[2932]: time="2025-12-06T11:43:01-03:00" level=debug msg="app state loaded"
Dec 06 11:43:01 volumio---sp-sala go-librespot[2932]: time="2025-12-06T11:43:01-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:43:01 volumio---sp-sala go-librespot[2932]: time="2025-12-06T11:43:01-03: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-06T11:43:01-03:00 is before 2025-12-08T00:00:00Z"
Dec 06 11:43:01 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
Dec 06 11:43:01 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: Error: connect ECONNREFUSED 127.0.0.1:9879
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: errno: -111,
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: code: 'ECONNREFUSED',
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: syscall: 'connect',
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: address: '127.0.0.1',
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: port: 9879,
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: response: undefined
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: }
Dec 06 11:43:02 volumio---sp-sala volumio[2311]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 06 11:43:05 volumio---sp-sala systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 7.
Dec 06 11:43:05 volumio---sp-sala systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:43:05 volumio---sp-sala systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon.
Dec 06 11:43:05 volumio---sp-sala go-librespot[2951]: go-librespot daemon starting...
Dec 06 11:43:05 volumio---sp-sala go-librespot[2952]: time="2025-12-06T11:43:05-03:00" level=info msg="running go-librespot 0.4.0"
Dec 06 11:43:05 volumio---sp-sala go-librespot[2952]: time="2025-12-06T11:43:05-03:00" level=debug msg="app state loaded"
Dec 06 11:43:05 volumio---sp-sala go-librespot[2952]: time="2025-12-06T11:43:05-03:00" level=info msg="api server listening on 127.0.0.1:9879"
Dec 06 11:43:05 volumio---sp-sala sudo[2960]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-06 11:42'
Dec 06 11:43:05 volumio---sp-sala sudo[2960]: 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="ec1ce6b3390e13e82b9cc0453f957c4f5298419e"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon Nov 17 16:31:40 UTC 2025"
VOLUMIO_VERSION="4.071"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5fbe1bcf6936184712979c0bfaf061f2"