-- Logs begin at Thu 2019-02-14 03:11:59 MST, end at Mon 2024-04-15 00:49:40 MST. -- Apr 15 00:48:00 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:00 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:00 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:00 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:00 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:00 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:00 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:00 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:02 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:02 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:02 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:02 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 394. Apr 15 00:48:02 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:02 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:02 headphones go-librespot[26705]: Librespot-go daemon starting... Apr 15 00:48:02 headphones go-librespot[26705]: time="2024-04-15T00:48:02-07:00" level=info msg="generated new device id: b698c1834944d5b3a0813c1b41191fdc8ace45a4" Apr 15 00:48:02 headphones go-librespot[26705]: time="2024-04-15T00:48:02-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:02 headphones go-librespot[26705]: time="2024-04-15T00:48:02-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:02 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:02 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:04 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:04 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:04 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:04 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:04 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:04 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:04 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:04 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:05 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:05 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:05 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:05 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:05 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:05 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:05 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:05 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:05 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 395. Apr 15 00:48:05 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:05 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:05 headphones go-librespot[26749]: Librespot-go daemon starting... Apr 15 00:48:05 headphones go-librespot[26749]: time="2024-04-15T00:48:05-07:00" level=info msg="generated new device id: 9990d99bb64b411c54e23186078e16a2f8bfd6b4" Apr 15 00:48:05 headphones go-librespot[26749]: time="2024-04-15T00:48:05-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:05 headphones go-librespot[26749]: time="2024-04-15T00:48:05-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:05 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:05 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:08 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:08 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:08 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:08 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 396. Apr 15 00:48:08 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:08 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:08 headphones go-librespot[26758]: Librespot-go daemon starting... Apr 15 00:48:08 headphones go-librespot[26758]: time="2024-04-15T00:48:08-07:00" level=info msg="generated new device id: 7e1b0ce7893895ea882c2ac755b038e8b1c13b86" Apr 15 00:48:08 headphones go-librespot[26758]: time="2024-04-15T00:48:08-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:08 headphones go-librespot[26758]: time="2024-04-15T00:48:08-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:08 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:08 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:09 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:10 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:10 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:10 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:10 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:10 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:10 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:10 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:10 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:11 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:11 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:11 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:12 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:12 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 397. Apr 15 00:48:12 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:12 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:12 headphones go-librespot[26801]: Librespot-go daemon starting... Apr 15 00:48:12 headphones go-librespot[26801]: time="2024-04-15T00:48:12-07:00" level=info msg="generated new device id: ebcab9dc46775222991313fbf8c76289d93f1919" Apr 15 00:48:12 headphones go-librespot[26801]: time="2024-04-15T00:48:12-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:12 headphones go-librespot[26801]: time="2024-04-15T00:48:12-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:12 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:12 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:14 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:14 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:15 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:15 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 398. Apr 15 00:48:15 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:15 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:15 headphones go-librespot[26808]: Librespot-go daemon starting... Apr 15 00:48:15 headphones go-librespot[26808]: time="2024-04-15T00:48:15-07:00" level=info msg="generated new device id: bce0741f795860cb76b866b859cb74ecbe06507b" Apr 15 00:48:15 headphones go-librespot[26808]: time="2024-04-15T00:48:15-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:15 headphones go-librespot[26808]: time="2024-04-15T00:48:15-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:15 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:15 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:15 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:15 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:15 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:15 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:15 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:15 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:15 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:15 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:17 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:17 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:18 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:18 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 399. Apr 15 00:48:18 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:18 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:18 headphones go-librespot[26850]: Librespot-go daemon starting... Apr 15 00:48:18 headphones go-librespot[26850]: time="2024-04-15T00:48:18-07:00" level=info msg="generated new device id: c1354bc25d4d627afe570f33fe6954905395f0b0" Apr 15 00:48:18 headphones go-librespot[26850]: time="2024-04-15T00:48:18-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:18 headphones go-librespot[26850]: time="2024-04-15T00:48:18-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:18 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:18 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:20 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:20 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:21 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:21 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:21 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:21 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:21 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:21 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:21 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:21 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:21 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:21 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 400. Apr 15 00:48:21 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:21 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:21 headphones go-librespot[26893]: Librespot-go daemon starting... Apr 15 00:48:21 headphones go-librespot[26893]: time="2024-04-15T00:48:21-07:00" level=info msg="generated new device id: afb8adbca2440a460fa847919da31a67e6aa4c26" Apr 15 00:48:21 headphones go-librespot[26893]: time="2024-04-15T00:48:21-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:21 headphones go-librespot[26893]: time="2024-04-15T00:48:21-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:21 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:21 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:23 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:23 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:25 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:25 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 401. Apr 15 00:48:25 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:25 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:25 headphones go-librespot[26901]: Librespot-go daemon starting... Apr 15 00:48:25 headphones go-librespot[26901]: time="2024-04-15T00:48:25-07:00" level=info msg="generated new device id: 16582631ddc2495dd066ee937630009c15c73b8d" Apr 15 00:48:25 headphones go-librespot[26901]: time="2024-04-15T00:48:25-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:25 headphones go-librespot[26901]: time="2024-04-15T00:48:25-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:25 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:25 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:26 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:26 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:26 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:26 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:26 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:26 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:26 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:26 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:26 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:26 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:28 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:28 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 402. Apr 15 00:48:28 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:28 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:28 headphones go-librespot[26944]: Librespot-go daemon starting... Apr 15 00:48:28 headphones go-librespot[26944]: time="2024-04-15T00:48:28-07:00" level=info msg="generated new device id: 603b8725522db5161e372a2e4f654172d8084687" Apr 15 00:48:28 headphones go-librespot[26944]: time="2024-04-15T00:48:28-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:28 headphones go-librespot[26944]: time="2024-04-15T00:48:28-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:28 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:28 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:29 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:29 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:31 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:31 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 403. Apr 15 00:48:31 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:31 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:31 headphones go-librespot[26952]: Librespot-go daemon starting... Apr 15 00:48:31 headphones go-librespot[26952]: time="2024-04-15T00:48:31-07:00" level=info msg="generated new device id: 3a252e50b101a98a674f8ec53adc446e03d04ed9" Apr 15 00:48:31 headphones go-librespot[26952]: time="2024-04-15T00:48:31-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:31 headphones go-librespot[26952]: time="2024-04-15T00:48:31-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:31 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:31 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:31 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:31 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:31 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:31 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:31 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:31 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:32 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:32 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:32 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:32 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:32 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:32 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:32 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:34 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:34 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 404. Apr 15 00:48:34 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:34 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:34 headphones go-librespot[26996]: Librespot-go daemon starting... Apr 15 00:48:34 headphones go-librespot[26996]: time="2024-04-15T00:48:34-07:00" level=info msg="generated new device id: dc9b1def4657e86efc5edb2ec66ec656975b2f8e" Apr 15 00:48:34 headphones go-librespot[26996]: time="2024-04-15T00:48:34-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:34 headphones go-librespot[26996]: time="2024-04-15T00:48:34-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:48:34 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:48:34 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:48:35 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:35 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:37 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:38 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:48:38 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 405. Apr 15 00:48:38 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:38 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:38 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:38 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:48:38 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:48:38 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:38 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:38 headphones go-librespot[27003]: Librespot-go daemon starting... Apr 15 00:48:38 headphones go-librespot[27003]: time="2024-04-15T00:48:38-07:00" level=info msg="generated new device id: f1f2a9e0f7599673192778a3b969707cc479c507" Apr 15 00:48:38 headphones go-librespot[27003]: time="2024-04-15T00:48:38-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:38 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:38 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:38 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:38 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:38 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:41 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:48:41 headphones go-librespot[27003]: time="2024-04-15T00:48:41-07:00" level=debug msg="new websocket client" Apr 15 00:48:41 headphones volumio[900]: info: Connection to go-librespot Websocket established Apr 15 00:48:43 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:43 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:43 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:43 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:43 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:43 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:43 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:43 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:43 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:44 headphones volumio[900]: info: Getting Spotify volume Apr 15 00:48:44 headphones volumio[900]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Apr 15 00:48:44 headphones volumio[900]: info: CoreCommandRouter::volumioGetState Apr 15 00:48:48 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:48 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:48 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:48 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:48 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:48 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:48 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:48 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:48 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:49 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:53 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:48:54 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:54 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:48:54 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:48:54 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:48:54 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:48:54 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:48:54 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:48:54 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:48:59 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:00 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:00 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:00 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:00 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:00 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:00 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:00 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:00 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:05 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:06 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:06 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:06 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:06 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:06 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:06 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:06 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:08 headphones go-librespot[27003]: time="2024-04-15T00:49:08-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp 35.186.224.25:443: i/o timeout" Apr 15 00:49:08 headphones volumio[900]: (node:900) UnhandledPromiseRejectionWarning: Error: socket hang up Apr 15 00:49:08 headphones volumio[900]: at connResetException (internal/errors.js:607:14) Apr 15 00:49:08 headphones volumio[900]: at Socket.socketOnEnd (_http_client.js:493:23) Apr 15 00:49:08 headphones volumio[900]: at Socket.emit (events.js:327:22) Apr 15 00:49:08 headphones volumio[900]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 15 00:49:08 headphones volumio[900]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 15 00:49:08 headphones volumio[900]: (node:900) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 34) Apr 15 00:49:08 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:08 headphones volumio[900]: info: Connection to go-librespot Websocket closed Apr 15 00:49:08 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:11 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:11 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:11 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:11 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:11 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:11 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:11 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 406. Apr 15 00:49:11 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:11 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:11 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:11 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:11 headphones go-librespot[27287]: Librespot-go daemon starting... Apr 15 00:49:11 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:11 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:11 headphones go-librespot[27287]: time="2024-04-15T00:49:11-07:00" level=info msg="generated new device id: 605fa68318aeef4bbfe88066730c9b7ee9b7d1fc" Apr 15 00:49:11 headphones go-librespot[27287]: time="2024-04-15T00:49:11-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:11 headphones go-librespot[27287]: time="2024-04-15T00:49:11-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:11 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:11 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:11 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:14 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:14 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:14 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:14 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 407. Apr 15 00:49:14 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:14 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:14 headphones go-librespot[27307]: Librespot-go daemon starting... Apr 15 00:49:14 headphones go-librespot[27307]: time="2024-04-15T00:49:14-07:00" level=info msg="generated new device id: 9e074daac0ab6f4bedf9d83c21753ef5220b48ae" Apr 15 00:49:14 headphones go-librespot[27307]: time="2024-04-15T00:49:14-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:14 headphones go-librespot[27307]: time="2024-04-15T00:49:14-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:14 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:14 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:16 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:16 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:16 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:16 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:16 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:16 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:16 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:16 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:16 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:17 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:17 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:17 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:17 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:17 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 408. Apr 15 00:49:17 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:17 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:17 headphones go-librespot[27351]: Librespot-go daemon starting... Apr 15 00:49:17 headphones go-librespot[27351]: time="2024-04-15T00:49:17-07:00" level=info msg="generated new device id: a73601b2563753da3fd46905afa57b189b502cb8" Apr 15 00:49:17 headphones go-librespot[27351]: time="2024-04-15T00:49:17-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:17 headphones go-librespot[27351]: time="2024-04-15T00:49:17-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:17 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:17 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:20 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:20 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:21 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:21 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 409. Apr 15 00:49:21 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:21 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:21 headphones go-librespot[27358]: Librespot-go daemon starting... Apr 15 00:49:21 headphones go-librespot[27358]: time="2024-04-15T00:49:21-07:00" level=info msg="generated new device id: 4362c73ee77206d03c972166cd691bd81568f77e" Apr 15 00:49:21 headphones go-librespot[27358]: time="2024-04-15T00:49:21-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:21 headphones go-librespot[27358]: time="2024-04-15T00:49:21-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:21 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:21 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:21 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:21 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:21 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:21 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:21 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:21 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:21 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:22 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:22 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:22 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:22 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:22 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:23 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:23 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:24 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:24 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 410. Apr 15 00:49:24 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:24 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:24 headphones go-librespot[27402]: Librespot-go daemon starting... Apr 15 00:49:24 headphones go-librespot[27402]: time="2024-04-15T00:49:24-07:00" level=info msg="generated new device id: 546a10b44cbdcc1dcd7e1352b70639379ccfd614" Apr 15 00:49:24 headphones go-librespot[27402]: time="2024-04-15T00:49:24-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:24 headphones go-librespot[27402]: time="2024-04-15T00:49:24-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:24 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:24 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:26 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:26 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:27 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:27 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:27 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 411. Apr 15 00:49:27 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:27 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:27 headphones go-librespot[27409]: Librespot-go daemon starting... Apr 15 00:49:27 headphones go-librespot[27409]: time="2024-04-15T00:49:27-07:00" level=info msg="generated new device id: e6f49b89a9bb30e4b6a39de18b57645ebb120a43" Apr 15 00:49:27 headphones go-librespot[27409]: time="2024-04-15T00:49:27-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:27 headphones go-librespot[27409]: time="2024-04-15T00:49:27-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:27 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:27 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:27 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:27 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:27 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:27 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:27 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:27 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:27 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:27 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:28 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:28 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:29 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:29 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:30 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:30 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 412. Apr 15 00:49:30 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:30 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:30 headphones go-librespot[27452]: Librespot-go daemon starting... Apr 15 00:49:30 headphones go-librespot[27452]: time="2024-04-15T00:49:30-07:00" level=info msg="generated new device id: 40908dd685b3815c7a11cd83a31219181b2c509a" Apr 15 00:49:30 headphones go-librespot[27452]: time="2024-04-15T00:49:30-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:30 headphones go-librespot[27452]: time="2024-04-15T00:49:30-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:30 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:30 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:32 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:32 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:32 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:33 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:33 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:33 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: hardware address 5e:62:8b:0a:e6:0e claims 192.168.1.100 Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: 10 second defence failed for 192.168.1.100 Apr 15 00:49:33 headphones avahi-daemon[530]: Withdrawing address record for 192.168.1.100 on wlan0. Apr 15 00:49:33 headphones avahi-daemon[530]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:33 headphones avahi-daemon[530]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: deleting route to 192.168.1.0/24 Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: deleting default route via 192.168.1.1 Apr 15 00:49:33 headphones volumio[900]: info: Discovery: A device disappeared from network Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: rebinding lease of 192.168.1.100 Apr 15 00:49:33 headphones dhcpcd[755]: wlan0: probing address 192.168.1.100/24 Apr 15 00:49:34 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:34 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 413. Apr 15 00:49:34 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:34 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:34 headphones go-librespot[27496]: Librespot-go daemon starting... Apr 15 00:49:34 headphones go-librespot[27496]: time="2024-04-15T00:49:34-07:00" level=info msg="generated new device id: a19db1f883ed9743d2f54ecd86792f8c79636fd2" Apr 15 00:49:34 headphones go-librespot[27496]: time="2024-04-15T00:49:34-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:34 headphones go-librespot[27496]: time="2024-04-15T00:49:34-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:34 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:34 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:35 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:35 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:37 headphones systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Apr 15 00:49:37 headphones systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 414. Apr 15 00:49:37 headphones systemd[1]: Stopped go-librespot Daemon. Apr 15 00:49:37 headphones systemd[1]: Started go-librespot Daemon. Apr 15 00:49:37 headphones go-librespot[27504]: Librespot-go daemon starting... Apr 15 00:49:37 headphones go-librespot[27504]: time="2024-04-15T00:49:37-07:00" level=info msg="generated new device id: 2e0401084f48736ec4b58fc7ee2640641a57e350" Apr 15 00:49:37 headphones go-librespot[27504]: time="2024-04-15T00:49:37-07:00" level=debug msg="stored credentials found for 31icucb27nogffupffy6mpy63nf4" Apr 15 00:49:37 headphones go-librespot[27504]: time="2024-04-15T00:49:37-07:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": dial tcp: lookup clienttoken.spotify.com: device or resource busy" Apr 15 00:49:37 headphones systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Apr 15 00:49:37 headphones systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 00:49:38 headphones volumio[900]: info: Initializing connection to go-librespot Websocket Apr 15 00:49:38 headphones volumio[900]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 00:49:38 headphones volumio[900]: info: Discovery: Browse raised the following error Error: dns service error: unknown Apr 15 00:49:38 headphones dhcpcd[755]: wlan0: leased 192.168.1.100 for 86400 seconds Apr 15 00:49:38 headphones avahi-daemon[530]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.100. Apr 15 00:49:38 headphones avahi-daemon[530]: New relevant interface wlan0.IPv4 for mDNS. Apr 15 00:49:38 headphones avahi-daemon[530]: Registering new address record for 192.168.1.100 on wlan0.IPv4. Apr 15 00:49:38 headphones dhcpcd[755]: wlan0: adding route to 192.168.1.0/24 Apr 15 00:49:38 headphones dhcpcd[755]: wlan0: adding default route via 192.168.1.1 Apr 15 00:49:39 headphones volumio[900]: info: Discovery: adding 59f78527-431e-4a4e-9fe7-40f3310c4b07 Apr 15 00:49:39 headphones volumio[900]: info: Discovery: Found device headphones Apr 15 00:49:39 headphones volumio[900]: info: CoreCommandRouter::volumioGetState Apr 15 00:49:39 headphones volumio[900]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 00:49:39 headphones volumio[900]: Error: The value NaN is not a number Apr 15 00:49:39 headphones volumio[900]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Apr 15 00:49:39 headphones volumio[900]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Apr 15 00:49:39 headphones volumio[900]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Apr 15 00:49:39 headphones volumio[900]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Apr 15 00:49:39 headphones volumio[900]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Apr 15 00:49:39 headphones volumio[900]: at Browser.emit (events.js:315:20) Apr 15 00:49:39 headphones volumio[900]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Apr 15 00:49:39 headphones volumio[900]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Apr 15 00:49:39 headphones volumio[900]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Apr 15 00:49:39 headphones volumio[900]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Apr 15 00:49:39 headphones volumio[900]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Apr 15 00:49:39 headphones volumio[900]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Apr 15 00:49:39 headphones volumio[900]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Apr 15 00:49:39 headphones volumio[900]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 00:49:40 headphones ntpd[639]: Listen normally on 19 wlan0 192.168.1.100:123 Apr 15 00:49:40 headphones ntpd[639]: new interface(s) found: waking up resolver Apr 15 00:49:40 headphones sudo[27543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-15 00:48 Apr 15 00:49:40 headphones sudo[27543]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"