Nov 08 09:39:00 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 10. Nov 08 09:39:00 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:00 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:00 vol4 go-librespot[2562]: go-librespot daemon starting... Nov 08 09:39:01 vol4 go-librespot[2564]: time="2025-11-08T09:39:01+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:01 vol4 go-librespot[2564]: time="2025-11-08T09:39:01+07:00" level=debug msg="app state loaded" Nov 08 09:39:01 vol4 go-librespot[2564]: time="2025-11-08T09:39:01+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:01 vol4 go-librespot[2564]: time="2025-11-08T09:39:01+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:01 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:01 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:02 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:02 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:04 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 11. Nov 08 09:39:04 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:04 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:04 vol4 go-librespot[2803]: go-librespot daemon starting... Nov 08 09:39:04 vol4 go-librespot[2813]: time="2025-11-08T09:39:04+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:04 vol4 go-librespot[2813]: time="2025-11-08T09:39:04+07:00" level=debug msg="app state loaded" Nov 08 09:39:04 vol4 go-librespot[2813]: time="2025-11-08T09:39:04+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:04 vol4 go-librespot[2813]: time="2025-11-08T09:39:04+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:04 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:04 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:05 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:05 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:07 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 12. Nov 08 09:39:07 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:07 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:07 vol4 go-librespot[3096]: go-librespot daemon starting... Nov 08 09:39:07 vol4 go-librespot[3105]: time="2025-11-08T09:39:07+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:07 vol4 go-librespot[3105]: time="2025-11-08T09:39:07+07:00" level=debug msg="app state loaded" Nov 08 09:39:07 vol4 go-librespot[3105]: time="2025-11-08T09:39:07+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:07 vol4 go-librespot[3105]: time="2025-11-08T09:39:07+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:07 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:07 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:08 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:08 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:10 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 13. Nov 08 09:39:10 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:10 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:10 vol4 go-librespot[3320]: go-librespot daemon starting... Nov 08 09:39:10 vol4 go-librespot[3329]: time="2025-11-08T09:39:10+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:10 vol4 go-librespot[3329]: time="2025-11-08T09:39:10+07:00" level=debug msg="app state loaded" Nov 08 09:39:10 vol4 go-librespot[3329]: time="2025-11-08T09:39:10+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:10 vol4 go-librespot[3329]: time="2025-11-08T09:39:10+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:10 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:10 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:11 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:11 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:12 vol4 dhcpcd[788]: eth0: carrier acquired Nov 08 09:39:12 vol4 dhcpcd[788]: eth0: IAID 32:22:c5:ab Nov 08 09:39:12 vol4 kernel: bcmgenet fd580000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Nov 08 09:39:12 vol4 dhcpcd[788]: eth0: adding address fe80::c91e:e9c6:3738:9b70 Nov 08 09:39:12 vol4 dhcpcd[788]: ipv6_addaddr1: Permission denied Nov 08 09:39:12 vol4 dhcpcd[788]: eth0: soliciting a DHCP lease Nov 08 09:39:13 vol4 dhcpcd[788]: eth0: offered 192.168.11.116 from 192.168.11.1 Nov 08 09:39:13 vol4 dhcpcd[788]: eth0: probing address 192.168.11.116/24 Nov 08 09:39:13 vol4 ifplugd(eth0)[961]: Link beat detected. Nov 08 09:39:13 vol4 ifplugd(eth0)[961]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 08 09:39:13 vol4 ifplugd(eth0)[961]: client: sending commands to dhcpcd process Nov 08 09:39:13 vol4 dhcpcd[788]: control command: dhcpcd eth0 Nov 08 09:39:13 vol4 dhcpcd[788]: control_free: No such file or directory Nov 08 09:39:13 vol4 dhcpcd[788]: eth0: soliciting an IPv6 router Nov 08 09:39:13 vol4 ifplugd(eth0)[961]: Program executed successfully. Nov 08 09:39:13 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 14. Nov 08 09:39:13 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:14 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:14 vol4 go-librespot[3634]: go-librespot daemon starting... Nov 08 09:39:14 vol4 go-librespot[3641]: time="2025-11-08T09:39:14+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:14 vol4 go-librespot[3641]: time="2025-11-08T09:39:14+07:00" level=debug msg="app state loaded" Nov 08 09:39:14 vol4 go-librespot[3641]: time="2025-11-08T09:39:14+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:14 vol4 go-librespot[3641]: time="2025-11-08T09:39:14+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:14 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:14 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:14 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:14 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:17 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 15. Nov 08 09:39:17 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:17 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:17 vol4 go-librespot[3907]: go-librespot daemon starting... Nov 08 09:39:17 vol4 go-librespot[3923]: time="2025-11-08T09:39:17+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:17 vol4 go-librespot[3923]: time="2025-11-08T09:39:17+07:00" level=debug msg="app state loaded" Nov 08 09:39:17 vol4 go-librespot[3923]: time="2025-11-08T09:39:17+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:17 vol4 go-librespot[3923]: time="2025-11-08T09:39:17+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Nov 08 09:39:17 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:17 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:17 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:17 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:17 vol4 dhcpcd[788]: eth0: leased 192.168.11.116 for 86400 seconds Nov 08 09:39:17 vol4 avahi-daemon[650]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.11.116. Nov 08 09:39:17 vol4 avahi-daemon[650]: New relevant interface eth0.IPv4 for mDNS. Nov 08 09:39:17 vol4 avahi-daemon[650]: Registering new address record for 192.168.11.116 on eth0.IPv4. Nov 08 09:39:17 vol4 dhcpcd[788]: eth0: adding route to 192.168.11.0/24 Nov 08 09:39:17 vol4 systemd[1]: welcome.service: Deactivated successfully. Nov 08 09:39:17 vol4 systemd[1]: Stopped welcome.service - Show a welcome message on console. Nov 08 09:39:17 vol4 systemd[1]: Stopping welcome.service - Show a welcome message on console... Nov 08 09:39:17 vol4 dhcpcd[788]: eth0: adding default route via 192.168.11.1 Nov 08 09:39:17 vol4 systemd[1]: Starting welcome.service - Show a welcome message on console... Nov 08 09:39:17 vol4 welcome[3989]: Resolved ip:[1] 192.168.11.116 Nov 08 09:39:17 vol4 systemd[1]: Finished welcome.service - Show a welcome message on console. Nov 08 09:39:17 vol4 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Nov 08 09:39:17 vol4 systemd[1]: Started nmbd.service - Samba NMB Daemon. Nov 08 09:39:17 vol4 systemd[1]: Starting winbind.service - Samba Winbind Daemon... Nov 08 09:39:18 vol4 winbindd[4021]: [2025/11/08 09:39:18.462009, 0] ../../source3/winbindd/winbindd.c:1440(main) Nov 08 09:39:18 vol4 winbindd[4021]: winbindd version 4.17.8-Raspbian started. Nov 08 09:39:18 vol4 winbindd[4021]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Nov 08 09:39:18 vol4 winbindd[4021]: [2025/11/08 09:39:18.491218, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Nov 08 09:39:18 vol4 winbindd[4021]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 08 09:39:18 vol4 systemd[1]: Started winbind.service - Samba Winbind Daemon. Nov 08 09:39:18 vol4 systemd[1]: Starting smbd.service - Samba SMB Daemon... Nov 08 09:39:18 vol4 volumio[1089]: info: Discovery: this is already registered, d8fdc3a9-2af1-4a36-8c34-4f5f23d2619d Nov 08 09:39:18 vol4 volumio[1089]: info: Discovery: Found device Vol4 Nov 08 09:39:18 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:39:18 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:39:19 vol4 smbd[4073]: [2025/11/08 09:39:19.073527, 0] ../../source3/smbd/server.c:1741(main) Nov 08 09:39:19 vol4 smbd[4073]: smbd version 4.17.8-Raspbian started. Nov 08 09:39:19 vol4 smbd[4073]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Nov 08 09:39:19 vol4 ntpd[946]: IO: Listen normally on 3 eth0 192.168.11.116:123 Nov 08 09:39:19 vol4 ntpd[946]: IO: new interface(s) found: waking up resolver Nov 08 09:39:19 vol4 ntpd[946]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Nov 08 09:39:19 vol4 ntpd[946]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Nov 08 09:39:19 vol4 ntpd[946]: DNS: Pool taking: 160.187.147.197 Nov 08 09:39:19 vol4 ntpd[946]: DNS: Pool taking: 103.130.217.41 Nov 08 09:39:19 vol4 ntpd[946]: DNS: Pool taking: 103.121.88.12 Nov 08 09:39:19 vol4 ntpd[946]: DNS: Pool taking: 103.199.18.137 Nov 08 09:39:19 vol4 ntpd[946]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Nov 08 09:39:19 vol4 systemd[1]: Started smbd.service - Samba SMB Daemon. Nov 08 09:39:19 vol4 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 08 09:39:19 vol4 systemd[1]: Reached target graphical.target - Graphical Interface. Nov 08 09:39:20 vol4 systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Nov 08 09:39:20 vol4 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 08 09:39:20 vol4 systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Nov 08 09:39:20 vol4 systemd[1]: Startup finished in 13.778s (kernel) + 1min 38.283s (userspace) = 1min 52.062s. Nov 08 09:39:20 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 16. Nov 08 09:39:20 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:20 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:20 vol4 go-librespot[4225]: go-librespot daemon starting... Nov 08 09:39:20 vol4 go-librespot[4229]: time="2025-11-08T09:39:20+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:20 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:20 vol4 go-librespot[4229]: time="2025-11-08T09:39:20+07:00" level=debug msg="app state loaded" Nov 08 09:39:20 vol4 go-librespot[4229]: time="2025-11-08T09:39:20+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:20 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:20 vol4 ntpd[946]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Nov 08 09:39:20 vol4 ntpd[946]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 103.129.126.10 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 103.221.223.185 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 103.72.56.71 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 115.165.161.155 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 2400:e920:0:5::14 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 2401:5b60:0:2::21 Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 2404:fbc0:0:21ef::a Nov 08 09:39:20 vol4 ntpd[946]: DNS: Pool taking: 2001:df7:c600:13:f816:3eff:fe1d:b3b5 Nov 08 09:39:20 vol4 ntpd[946]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Nov 08 09:39:21 vol4 go-librespot[4229]: time="2025-11-08T09:39:21+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:20+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:21 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:21 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:21 vol4 ntpd[946]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Nov 08 09:39:21 vol4 ntpd[946]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Nov 08 09:39:21 vol4 ntpd[946]: DNS: Pool taking: 103.179.189.20 Nov 08 09:39:21 vol4 ntpd[946]: DNS: Pool taking: 103.121.88.11 Nov 08 09:39:21 vol4 ntpd[946]: DNS: Pool taking: 103.221.223.143 Nov 08 09:39:21 vol4 ntpd[946]: DNS: Pool taking: 45.252.250.189 Nov 08 09:39:21 vol4 ntpd[946]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Nov 08 09:39:22 vol4 ntpd[946]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Nov 08 09:39:22 vol4 volumio[1089]: info: Volumio Network Manager: Network status updated: 1 Nov 08 09:39:22 vol4 ntpd[946]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Nov 08 09:39:22 vol4 ntpd[946]: DNS: Pool skipping: 103.121.88.12 Nov 08 09:39:22 vol4 ntpd[946]: DNS: Pool skipping: 103.221.223.185 Nov 08 09:39:22 vol4 ntpd[946]: DNS: Pool taking: 103.184.124.254 Nov 08 09:39:22 vol4 ntpd[946]: DNS: Pool skipping: 103.199.18.137 Nov 08 09:39:22 vol4 ntpd[946]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Nov 08 09:39:23 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:23 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:24 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 17. Nov 08 09:39:24 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:24 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:24 vol4 go-librespot[4473]: go-librespot daemon starting... Nov 08 09:39:24 vol4 go-librespot[4475]: time="2025-11-08T09:39:24+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:24 vol4 go-librespot[4475]: time="2025-11-08T09:39:24+07:00" level=debug msg="app state loaded" Nov 08 09:39:24 vol4 go-librespot[4475]: time="2025-11-08T09:39:24+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:24 vol4 go-librespot[4475]: time="2025-11-08T09:39:24+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:24+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:24 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:24 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:26 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:26 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:27 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 18. Nov 08 09:39:27 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:27 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:27 vol4 go-librespot[4661]: go-librespot daemon starting... Nov 08 09:39:27 vol4 go-librespot[4662]: time="2025-11-08T09:39:27+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:27 vol4 go-librespot[4662]: time="2025-11-08T09:39:27+07:00" level=debug msg="app state loaded" Nov 08 09:39:27 vol4 go-librespot[4662]: time="2025-11-08T09:39:27+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:28 vol4 go-librespot[4662]: time="2025-11-08T09:39:28+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:27+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:28 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:28 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:29 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:29 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:31 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 19. Nov 08 09:39:31 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:31 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:31 vol4 go-librespot[4866]: go-librespot daemon starting... Nov 08 09:39:31 vol4 go-librespot[4872]: time="2025-11-08T09:39:31+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:31 vol4 go-librespot[4872]: time="2025-11-08T09:39:31+07:00" level=debug msg="app state loaded" Nov 08 09:39:31 vol4 go-librespot[4872]: time="2025-11-08T09:39:31+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:31 vol4 go-librespot[4872]: time="2025-11-08T09:39:31+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:31+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:31 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:31 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:32 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:32 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:34 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 20. Nov 08 09:39:34 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:34 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:34 vol4 go-librespot[5086]: go-librespot daemon starting... Nov 08 09:39:34 vol4 go-librespot[5088]: time="2025-11-08T09:39:34+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:34 vol4 go-librespot[5088]: time="2025-11-08T09:39:34+07:00" level=debug msg="app state loaded" Nov 08 09:39:34 vol4 go-librespot[5088]: time="2025-11-08T09:39:34+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:35 vol4 go-librespot[5088]: time="2025-11-08T09:39:35+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:35+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:35 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:35 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:35 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:35 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:38 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 21. Nov 08 09:39:38 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:38 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:38 vol4 go-librespot[5297]: go-librespot daemon starting... Nov 08 09:39:38 vol4 go-librespot[5304]: time="2025-11-08T09:39:38+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:38 vol4 go-librespot[5304]: time="2025-11-08T09:39:38+07:00" level=debug msg="app state loaded" Nov 08 09:39:38 vol4 go-librespot[5304]: time="2025-11-08T09:39:38+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:38 vol4 go-librespot[5304]: time="2025-11-08T09:39:38+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:38+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:38 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:38 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:38 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:38 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:41 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 22. Nov 08 09:39:41 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:41 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:41 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:41 vol4 go-librespot[5522]: go-librespot daemon starting... Nov 08 09:39:41 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:41 vol4 go-librespot[5530]: time="2025-11-08T09:39:41+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:41 vol4 go-librespot[5530]: time="2025-11-08T09:39:41+07:00" level=debug msg="app state loaded" Nov 08 09:39:41 vol4 go-librespot[5530]: time="2025-11-08T09:39:41+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:42 vol4 go-librespot[5530]: time="2025-11-08T09:39:42+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:41+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:42 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:42 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:42 vol4 upmpdcli[5569]: writing RSA key Nov 08 09:39:44 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:44 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:45 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 23. Nov 08 09:39:45 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:45 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:45 vol4 go-librespot[5788]: go-librespot daemon starting... Nov 08 09:39:45 vol4 go-librespot[5791]: time="2025-11-08T09:39:45+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:45 vol4 go-librespot[5791]: time="2025-11-08T09:39:45+07:00" level=debug msg="app state loaded" Nov 08 09:39:45 vol4 go-librespot[5791]: time="2025-11-08T09:39:45+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:45 vol4 go-librespot[5791]: time="2025-11-08T09:39:45+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:45+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:45 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:45 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:47 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:47 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:48 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 24. Nov 08 09:39:48 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:48 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:48 vol4 go-librespot[6038]: go-librespot daemon starting... Nov 08 09:39:48 vol4 go-librespot[6045]: time="2025-11-08T09:39:48+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:48 vol4 go-librespot[6045]: time="2025-11-08T09:39:48+07:00" level=debug msg="app state loaded" Nov 08 09:39:48 vol4 go-librespot[6045]: time="2025-11-08T09:39:48+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:49 vol4 go-librespot[6045]: time="2025-11-08T09:39:49+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:48+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:49 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:49 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:50 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:50 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:52 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 25. Nov 08 09:39:52 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:52 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:52 vol4 go-librespot[6292]: go-librespot daemon starting... Nov 08 09:39:52 vol4 go-librespot[6301]: time="2025-11-08T09:39:52+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:52 vol4 go-librespot[6301]: time="2025-11-08T09:39:52+07:00" level=debug msg="app state loaded" Nov 08 09:39:52 vol4 go-librespot[6301]: time="2025-11-08T09:39:52+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:52 vol4 go-librespot[6301]: time="2025-11-08T09:39:52+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:52+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:52 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:52 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:53 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:53 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:55 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 26. Nov 08 09:39:55 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:55 vol4 go-librespot[6554]: go-librespot daemon starting... Nov 08 09:39:55 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:55 vol4 go-librespot[6560]: time="2025-11-08T09:39:55+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:55 vol4 go-librespot[6560]: time="2025-11-08T09:39:55+07:00" level=debug msg="app state loaded" Nov 08 09:39:55 vol4 go-librespot[6560]: time="2025-11-08T09:39:55+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:56 vol4 go-librespot[6560]: time="2025-11-08T09:39:56+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:55+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:56 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:56 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:56 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:56 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:39:59 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 27. Nov 08 09:39:59 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:59 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:39:59 vol4 go-librespot[6747]: go-librespot daemon starting... Nov 08 09:39:59 vol4 go-librespot[6753]: time="2025-11-08T09:39:59+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:39:59 vol4 go-librespot[6753]: time="2025-11-08T09:39:59+07:00" level=debug msg="app state loaded" Nov 08 09:39:59 vol4 go-librespot[6753]: time="2025-11-08T09:39:59+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:39:59 vol4 go-librespot[6753]: time="2025-11-08T09:39:59+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:39:59+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:39:59 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:39:59 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:39:59 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:39:59 vol4 volumio[1089]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:40:00 vol4 sudo[6829]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 08 09:40:00 vol4 sudo[6829]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 08 09:40:00 vol4 sudo[6827]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 08 09:40:00 vol4 sudo[6827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 08 09:40:00 vol4 sudo[6827]: pam_unix(sudo:session): session closed for user root Nov 08 09:40:00 vol4 sudo[6829]: pam_unix(sudo:session): session closed for user root Nov 08 09:40:00 vol4 volumio[1089]: verbose: New Socket.io Connection to 192.168.11.116 from 192.168.11.113 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 08 09:40:01 vol4 sudo[6905]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 08 09:40:01 vol4 sudo[6905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 08 09:40:01 vol4 sudo[6904]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 08 09:40:01 vol4 sudo[6904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 08 09:40:01 vol4 sudo[6905]: pam_unix(sudo:session): session closed for user root Nov 08 09:40:01 vol4 sudo[6904]: pam_unix(sudo:session): session closed for user root Nov 08 09:40:02 vol4 volumio[1089]: verbose: New Socket.io Connection to 192.168.11.116 from 192.168.11.113 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetVisibleSources Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:40:02 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 08 09:40:02 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 28. Nov 08 09:40:02 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:02 vol4 volumio[1089]: info: Received Get System Info Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 08 09:40:02 vol4 volumio[1089]: info: Discovery: Getting this device information Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:40:02 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:40:02 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:40:02 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:02 vol4 go-librespot[6957]: go-librespot daemon starting... Nov 08 09:40:02 vol4 go-librespot[6958]: time="2025-11-08T09:40:02+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:40:02 vol4 go-librespot[6958]: time="2025-11-08T09:40:02+07:00" level=debug msg="app state loaded" Nov 08 09:40:02 vol4 go-librespot[6958]: time="2025-11-08T09:40:02+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:40:02 vol4 volumio[1089]: info: Listing playlists Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 08 09:40:02 vol4 volumio[1089]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 08 09:40:02 vol4 volumio[1089]: info: Initializing connection to go-librespot Websocket Nov 08 09:40:03 vol4 go-librespot[6958]: time="2025-11-08T09:40:03+07:00" level=debug msg="new websocket client" Nov 08 09:40:03 vol4 volumio[1089]: info: Connection to go-librespot Websocket established Nov 08 09:40:03 vol4 go-librespot[6958]: time="2025-11-08T09:40:03+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:40:02+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:40:03 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:40:03 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:40:03 vol4 volumio[1089]: info: Connection to go-librespot Websocket closed Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 08 09:40:04 vol4 volumio[1089]: info: Received Get System Info Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 08 09:40:04 vol4 volumio[1089]: info: Discovery: Getting this device information Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:40:04 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 08 09:40:04 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 08 09:40:05 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 08 09:40:05 vol4 volumio[1089]: info: Received Get System Info Nov 08 09:40:05 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 08 09:40:05 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 08 09:40:05 vol4 volumio[1089]: info: Discovery: Getting this device information Nov 08 09:40:05 vol4 volumio[1089]: info: CoreCommandRouter::volumioGetState Nov 08 09:40:05 vol4 volumio[1089]: info: CorePlayQueue::getTrack 0 Nov 08 09:40:05 vol4 volumio[1089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 08 09:40:06 vol4 volumio[1089]: info: Getting Spotify volume Nov 08 09:40:06 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 29. Nov 08 09:40:06 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:06 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:06 vol4 go-librespot[7112]: go-librespot daemon starting... Nov 08 09:40:06 vol4 volumio[1089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 08 09:40:06 vol4 volumio[1089]: Error: connect ECONNREFUSED 127.0.0.1:9879 Nov 08 09:40:06 vol4 volumio[1089]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Nov 08 09:40:06 vol4 volumio[1089]: errno: -111, Nov 08 09:40:06 vol4 volumio[1089]: code: 'ECONNREFUSED', Nov 08 09:40:06 vol4 volumio[1089]: syscall: 'connect', Nov 08 09:40:06 vol4 volumio[1089]: address: '127.0.0.1', Nov 08 09:40:06 vol4 volumio[1089]: port: 9879, Nov 08 09:40:06 vol4 volumio[1089]: response: undefined Nov 08 09:40:06 vol4 volumio[1089]: } Nov 08 09:40:06 vol4 go-librespot[7113]: time="2025-11-08T09:40:06+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:40:06 vol4 go-librespot[7113]: time="2025-11-08T09:40:06+07:00" level=debug msg="app state loaded" Nov 08 09:40:06 vol4 go-librespot[7113]: time="2025-11-08T09:40:06+07:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 08 09:40:06 vol4 volumio[1089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 08 09:40:06 vol4 go-librespot[7113]: time="2025-11-08T09:40:06+07:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": tls: failed to verify certificate: x509: certificate has expired or is not yet valid: current time 2025-11-08T09:40:06+07:00 is before 2025-12-08T00:00:00Z" Nov 08 09:40:06 vol4 systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Nov 08 09:40:06 vol4 systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Nov 08 09:40:09 vol4 sudo[7134]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-08 09:39' Nov 08 09:40:09 vol4 sudo[7134]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Nov 08 09:40:09 vol4 systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 30. Nov 08 09:40:09 vol4 systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:09 vol4 systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Nov 08 09:40:09 vol4 go-librespot[7136]: go-librespot daemon starting... Nov 08 09:40:09 vol4 go-librespot[7137]: time="2025-11-08T09:40:09+07:00" level=info msg="running go-librespot 0.4.0" Nov 08 09:40:09 vol4 go-librespot[7137]: time="2025-11-08T09:40:09+07:00" level=debug msg="app state loaded" Nov 08 09:40:09 vol4 go-librespot[7137]: time="2025-11-08T09:40:09+07:00" level=info msg="api server listening on 127.0.0.1:9879" 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="5ef3d56f987d109f3e21bfa246dbbb723cf6a917" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="c7bff9654d2984a81c5720476c2c8ac531869c54" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Oct 9 18:08:11 UTC 2025" VOLUMIO_VERSION="4.062" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="00524295c246b7d72f125e4c54b86a88"