Mar 26 08:26:14 volumio volumiossh-tunnel[369935]: ssh: Could not resolve hostname eu3.myvolumio.org: Device or resource busy Mar 26 08:26:14 volumio autossh[369932]: ssh exited prematurely with status 255; autossh exiting Mar 26 08:26:14 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 26 08:26:14 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 26 08:26:15 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 5. Mar 26 08:26:15 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:15 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:15 volumio autossh[370014]: port set to 0, monitoring disabled Mar 26 08:26:15 volumio autossh[370014]: starting ssh (count 1) Mar 26 08:26:15 volumio autossh[370014]: ssh child pid is 370017 Mar 26 08:26:15 volumio go-librespot[176925]: time="2026-03-26T08:26:15Z" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 08:26:17 volumio go-librespot[176925]: time="2026-03-26T08:26:17Z" level=error msg="did not receive last pong from dealer, 80s passed" Mar 26 08:26:17 volumio go-librespot[176925]: time="2026-03-26T08:26:17Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew1.spotify.com: i/o timeout" Mar 26 08:26:25 volumio volumio[1232]: error: error Mar 26 08:26:25 volumio volumio[1232]: error: error Mar 26 08:26:25 volumio volumio[1232]: error: error Mar 26 08:26:25 volumio volumio[1232]: error: error Mar 26 08:26:26 volumio volumio[1232]: error: error Mar 26 08:26:26 volumio volumio[1232]: error: error Mar 26 08:26:38 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 26 08:26:43 volumio volumiossh-tunnel[370017]: ssh: Could not resolve hostname eu3.myvolumio.org: Device or resource busy Mar 26 08:26:43 volumio autossh[370014]: ssh exited prematurely with status 255; autossh exiting Mar 26 08:26:43 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 26 08:26:43 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 26 08:26:43 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 6. Mar 26 08:26:43 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:43 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:43 volumio autossh[370111]: port set to 0, monitoring disabled Mar 26 08:26:43 volumio autossh[370111]: starting ssh (count 1) Mar 26 08:26:43 volumio autossh[370111]: ssh child pid is 370114 Mar 26 08:26:45 volumio go-librespot[176925]: time="2026-03-26T08:26:45Z" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 08:26:47 volumio go-librespot[176925]: time="2026-03-26T08:26:47Z" level=error msg="did not receive last pong from dealer, 110s passed" Mar 26 08:26:47 volumio go-librespot[176925]: time="2026-03-26T08:26:47Z" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew1.spotify.com: i/o timeout" Mar 26 08:26:53 volumio volumio[1232]: info: Tunnel connection is inactive, restarting it Mar 26 08:26:53 volumio volumio[1232]: info: Starting Tunnel 1 Mar 26 08:26:53 volumio volumio[1232]: info: Starting Tunnel Connection Checker Mar 26 08:26:53 volumio sudo[370148]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 26 08:26:53 volumio sudo[370148]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 26 08:26:53 volumio autossh[370111]: received signal to exit (15) Mar 26 08:26:53 volumio systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Mar 26 08:26:53 volumio systemd[1]: sshtunnel.service: Deactivated successfully. Mar 26 08:26:53 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:53 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:26:53 volumio sudo[370148]: pam_unix(sudo:session): session closed for user root Mar 26 08:26:53 volumio volumio[1232]: info: Remote SSH Started Mar 26 08:26:53 volumio autossh[370151]: port set to 0, monitoring disabled Mar 26 08:26:53 volumio autossh[370151]: starting ssh (count 1) Mar 26 08:26:53 volumio autossh[370151]: ssh child pid is 370154 Mar 26 08:27:08 volumio volumio[1232]: error: error Mar 26 08:27:08 volumio volumio[1232]: error: error Mar 26 08:27:08 volumio volumio[1232]: error: error Mar 26 08:27:08 volumio volumio[1232]: error: error Mar 26 08:27:08 volumio volumio[1232]: error: error Mar 26 08:27:09 volumio volumio[1232]: error: error Mar 26 08:27:09 volumio volumio[1232]: error: error Mar 26 08:27:15 volumio go-librespot[176925]: time="2026-03-26T08:27:15Z" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 26 08:27:17 volumio go-librespot[176925]: time="2026-03-26T08:27:17Z" level=error msg="did not receive last pong from dealer, 140s passed" Mar 26 08:27:17 volumio go-librespot[176925]: time="2026-03-26T08:27:17Z" level=error msg="did not receive last pong ack from accesspoint, 243s passed" Mar 26 08:27:17 volumio go-librespot[176925]: panic: runtime error: invalid memory address or nil pointer dereference Mar 26 08:27:17 volumio go-librespot[176925]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x18 pc=0x8a63fb] Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 60 gp=0xc00046d500 m=5 mp=0xc000100008 [running]: Mar 26 08:27:17 volumio go-librespot[176925]: panic({0xba9580?, 0x13f6450?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/panic.go:802 +0x168 fp=0xc000207ed8 sp=0xc000207e28 pc=0x4889e8 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.panicmem(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/panic.go:262 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.sigpanic() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/signal_unix.go:925 +0x359 fp=0xc000207f38 sp=0xc000207ed8 pc=0x48afb9 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0xc0001ce960) Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:380 +0x1fb fp=0xc000207fc8 sp=0xc000207f38 pc=0x8a63fb Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap2() Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:277 +0x25 fp=0xc000207fe0 sp=0xc000207fc8 pc=0x8a5905 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000207fe8 sp=0xc000207fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 84 Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:277 +0xff Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 1 gp=0xc000002380 m=nil [select, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc000295c60?, 0x2?, 0x50?, 0xa8?, 0xc000295bfc?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000295a70 sp=0xc000295a50 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc000295c60, 0xc000295bf8, 0x0?, 0x0, 0xbe7660?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000295bb0 sp=0xc000295a70 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0xc0002660a0, 0xc000295d80) Mar 26 08:27:17 volumio go-librespot[176925]: /src/zeroconf/zeroconf.go:283 +0x29a fp=0xc000295cf8 sp=0xc000295bb0 pc=0x9a379a Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).withAppPlayer(0xc000184e00, {0xe0b228, 0x1483020}, 0xc0002708c0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:340 +0x590 fp=0xc000295e10 sp=0xc000295cf8 pc=0xa30810 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).withCredentials(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:209 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).SpotifyToken(0xc000184e00, {0xe0b228, 0x1483020}, {0xc000014e38?, 0xce6b7b?}, {0xc000268000?, 0x2697?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:201 +0xc5 fp=0xc000295e68 sp=0xc000295e10 pc=0xa2fcc5 Mar 26 08:27:17 volumio go-librespot[176925]: main.main() Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:593 +0x745 fp=0xc000295f50 sp=0xc000295e68 pc=0xa32965 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.main() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:285 +0x29d fp=0xc000295fe0 sp=0xc000295f50 pc=0x45509d Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000295fe8 sp=0xc000295fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 2 gp=0xc000002e00 m=nil [force gc (idle), 3 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x7d71636937f5?, 0x684515c0f8fa?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005cfa8 sp=0xc00005cf88 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goparkunlock(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:466 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.forcegchelper() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:373 +0xb3 fp=0xc00005cfe0 sp=0xc00005cfa8 pc=0x4553d3 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005cfe8 sp=0xc00005cfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.init.7 in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:361 +0x1a Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 3 gp=0xc000003340 m=nil [GC sweep wait]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x1460901?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005d780 sp=0xc00005d760 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goparkunlock(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:466 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.bgsweep(0xc00007e000) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgcsweep.go:323 +0xdf fp=0xc00005d7c8 sp=0xc00005d780 pc=0x43f29f Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcenable.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:212 +0x25 fp=0xc00005d7e0 sp=0xc00005d7c8 pc=0x4332a5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005d7e8 sp=0xc00005d7e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcenable in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:212 +0x66 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 4 gp=0xc000003500 m=nil [GC scavenge wait]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x124608?, 0xbd42d?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005df78 sp=0xc00005df58 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goparkunlock(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:466 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.(*scavengerState).park(0x1461b00) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc00005dfa8 sp=0xc00005df78 pc=0x43cd29 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.bgscavenge(0xc00007e000) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0xc00005dfc8 sp=0xc00005dfa8 pc=0x43d2d9 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcenable.gowrap2() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:213 +0x25 fp=0xc00005dfe0 sp=0xc00005dfc8 pc=0x433245 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005dfe8 sp=0xc00005dfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcenable in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:213 +0xa5 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 5 gp=0xc000003a40 m=nil [GOMAXPROCS updater (idle), 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005e788 sp=0xc00005e768 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goparkunlock(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:466 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.updateMaxProcsGoroutine() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:6720 +0xe7 fp=0xc00005e7e0 sp=0xc00005e788 pc=0x4632c7 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005e7e8 sp=0xc00005e7e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:6708 +0x37 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 6 gp=0xc0000aa000 m=nil [finalizer wait, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x464295?, 0x42ac45?, 0xb8?, 0x1?, 0xc000002380?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005c620 sp=0xc00005c600 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.runFinalizers() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mfinal.go:210 +0x107 fp=0xc00005c7e0 sp=0xc00005c620 pc=0x4321a7 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005c7e8 sp=0xc00005c7e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.createfing in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mfinal.go:172 +0x3d Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 7 gp=0xc0000aae00 m=nil [cleanup wait, 28 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x7f4b2a6d0200?, 0xc00005ef90?, 0xb5?, 0x7a?, 0x7f4b2a6d0200?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005ef68 sp=0xc00005ef48 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goparkunlock(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:466 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.(*cleanupQueue).dequeue(0x1461f40) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mcleanup.go:439 +0xc5 fp=0xc00005efa0 sp=0xc00005ef68 pc=0x42f3c5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.runCleanups() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mcleanup.go:635 +0x45 fp=0xc00005efe0 sp=0xc00005efa0 pc=0x42fa85 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005efe8 sp=0xc00005efe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mcleanup.go:589 +0xa5 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 10 gp=0xc0000ab180 m=nil [IO wait, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006ca58 sp=0xc00006ca38 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.netpollblock(0xc00006caa8?, 0x41f886?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006ca90 sp=0xc00006ca58 pc=0x44d977 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.runtime_pollWait(0x7f4b31069e00, 0x72) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006cab0 sp=0xc00006ca90 pc=0x4880e5 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).wait(0xc000182900?, 0x900000036?, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006cad8 sp=0xc00006cab0 pc=0x50a827 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).waitRead(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*FD).Accept(0xc000182900) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00006cb80 sp=0xc00006cad8 pc=0x50fc4c Mar 26 08:27:17 volumio go-librespot[176925]: net.(*netFD).accept(0xc000182900) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00006cc38 sp=0xc00006cb80 pc=0x57c449 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*TCPListener).accept(0xc000089300) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00006cc88 sp=0xc00006cc38 pc=0x591bbb Mar 26 08:27:17 volumio go-librespot[176925]: net.(*TCPListener).Accept(0xc000089300) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00006ccb8 sp=0xc00006cc88 pc=0x590d90 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*onceCloseListener).Accept(0xc0002487e0?) Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x24 fp=0xc00006ccd0 sp=0xc00006ccb8 pc=0x73aaa4 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Server).Serve(0xc00013a000, {0xe0a190, 0xc000089300}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00006ce00 sp=0xc00006ccd0 pc=0x712a0c Mar 26 08:27:17 volumio go-librespot[176925]: net/http.Serve(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2971 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*ConcreteApiServer).serve(0xc0002483f0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/api_server.go:666 +0x90c fp=0xc00006cfc8 sp=0xc00006ce00 pc=0xa25c4c Mar 26 08:27:17 volumio go-librespot[176925]: main.NewApiServer.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/api_server.go:332 +0x25 fp=0xc00006cfe0 sp=0xc00006cfc8 pc=0xa24985 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006cfe8 sp=0xc00006cfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by main.NewApiServer in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/api_server.go:332 +0x2ff Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 54 gp=0xc0000ab340 m=nil [IO wait, 3 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc00006ed58?, 0x486a25?, 0xa0?, 0x81?, 0x165?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006ed28 sp=0xc00006ed08 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006ed60 sp=0xc00006ed28 pc=0x44d977 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.runtime_pollWait(0x7f4b31069400, 0x72) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006ed80 sp=0xc00006ed60 pc=0x4880e5 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).wait(0xc000182680?, 0x7f4b3106fb20?, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006eda8 sp=0xc00006ed80 pc=0x50a827 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).waitRead(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*FD).RawRead(0xc000182680, 0xc000359360) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc00006ee08 sp=0xc00006eda8 pc=0x5108c5 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*rawConn).Read(0xc000482010, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc00006ee40 sp=0xc00006ee08 pc=0x58ccf6 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003bc120, 0xc000113920, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc00006eea0 sp=0xc00006ee40 pc=0x941a85 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0xc0002bc290, {0xc00051a000, 0x10000, 0x10000}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x225 fp=0xc00006ef48 sp=0xc00006eea0 pc=0x945265 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/grandcat/zeroconf.(*Server).recv4(0xc0002c2120, 0xc0002bc280) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xc7 fp=0xc00006efc0 sp=0xc00006ef48 pc=0x99e627 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x25 fp=0xc00006efe0 sp=0xc00006efc0 pc=0x99e2c5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006efe8 sp=0xc00006efe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 25 Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x78 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 55 gp=0xc0000ab500 m=nil [IO wait, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x200000000?, 0x60?, 0x29?, 0xc0004e89c0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006dce0 sp=0xc00006dcc0 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006dd18 sp=0xc00006dce0 pc=0x44d977 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.runtime_pollWait(0x7f4b31069200, 0x72) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006dd38 sp=0xc00006dd18 pc=0x4880e5 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).wait(0xc000182700?, 0x7f4b2a71d5c0?, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006dd60 sp=0xc00006dd38 pc=0x50a827 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).waitRead(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*FD).RawRead(0xc000182700, 0xc0004ce820) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc00006ddc0 sp=0xc00006dd60 pc=0x5108c5 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*rawConn).Read(0xc000482020, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc00006ddf8 sp=0xc00006ddc0 pc=0x58ccf6 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003bc140, 0xc0004e7500, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc00006de58 sp=0xc00006ddf8 pc=0x941a85 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0xc0002bc2e0, {0xc00027e000, 0x10000, 0x10000}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x265 fp=0xc00006df48 sp=0xc00006de58 pc=0x948725 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/grandcat/zeroconf.(*Server).recv6(0xc0002c2120, 0xc0002bc2d0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xc7 fp=0xc00006dfc0 sp=0xc00006df48 pc=0x99e7e7 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x25 fp=0xc00006dfe0 sp=0xc00006dfc0 pc=0x99e265 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006dfe8 sp=0xc00006dfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 25 Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xd9 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 21 gp=0xc000102380 m=nil [GC worker (idle), 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x0?, 0x50?, 0x48?, 0xc0000948c0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005ff38 sp=0xc00005ff18 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkWorker(0xc0001437a0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00005ffc8 sp=0xc00005ff38 pc=0x43598b Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00005ffe0 sp=0xc00005ffc8 pc=0x435865 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005ffe8 sp=0xc00005ffe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcBgMarkStartWorkers in goroutine 19 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 16 gp=0xc0000ab880 m=nil [IO wait, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc0001cd310?, 0x925374?, 0x45?, 0x66?, 0xb?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0001cd2e0 sp=0xc0001cd2c0 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0001cd318 sp=0xc0001cd2e0 pc=0x44d977 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.runtime_pollWait(0x7f4b31069a00, 0x72) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0001cd338 sp=0xc0001cd318 pc=0x4880e5 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).wait(0xc000182a80?, 0xc000275000?, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0001cd360 sp=0xc0001cd338 pc=0x50a827 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).waitRead(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*FD).Read(0xc000182a80, {0xc000275000, 0x1000, 0x1000}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0001cd3f8 sp=0xc0001cd360 pc=0x50bb19 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*netFD).Read(0xc000182a80, {0xc000275000?, 0x488f0e?, 0x1?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0001cd440 sp=0xc0001cd3f8 pc=0x57a5a5 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*conn).Read(0xc000060388, {0xc000275000?, 0x2?, 0x45ec3f?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0001cd488 sp=0xc0001cd440 pc=0x588ac5 Mar 26 08:27:17 volumio go-librespot[176925]: io.(*multiReader).Read(0xc000012ed0, {0xc000275000, 0x1000, 0x1000}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/io/multi.go:26 +0x93 fp=0xc0001cd4d0 sp=0xc0001cd488 pc=0x4c9a73 Mar 26 08:27:17 volumio go-librespot[176925]: bufio.(*Reader).fill(0xc00008aea0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc0001cd508 sp=0xc0001cd4d0 pc=0x68e1c3 Mar 26 08:27:17 volumio go-librespot[176925]: bufio.(*Reader).ReadByte(0xc00008aea0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/bufio/bufio.go:273 +0x27 fp=0xc0001cd528 sp=0xc0001cd508 pc=0x68e8e7 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.readFrameHeader(0xc00008aea0, {0xc0000ed3e8, 0x8, 0x8}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x85 fp=0xc0001cd5b8 sp=0xc0001cd528 pc=0x84aa65 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).readFrameHeader(0xc0000ed380, {0xe0b1f0, 0x1483020}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xd6 fp=0xc0001cd6f8 sp=0xc0001cd5b8 pc=0x84c6b6 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).readLoop(0xc0000ed380, {0xe0b1f0, 0x1483020}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x65 fp=0xc0001cd858 sp=0xc0001cd6f8 pc=0x84c025 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).reader(0xc0000ed380, {0xe0b1f0, 0x1483020}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0x10f fp=0xc0001cd948 sp=0xc0001cd858 pc=0x84d4af Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).Reader(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).Read(0xc000248468?, {0xe0b1f0?, 0x1483020?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x1e fp=0xc0001cd978 sp=0xc0001cd948 pc=0x84b67e Mar 26 08:27:17 volumio go-librespot[176925]: main.(*ConcreteApiServer).serve.func17({0xe0a310, 0xc0001ce780}, 0xc000276f00?) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/api_server.go:636 +0x3ac fp=0xc0001cda68 sp=0xc0001cd978 pc=0xa2640c Mar 26 08:27:17 volumio go-librespot[176925]: net/http.HandlerFunc.ServeHTTP(0xc000110000?, {0xe0a310?, 0xc0001ce780?}, 0x2000000000000?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0001cda90 sp=0xc0001cda68 pc=0x70f109 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*ServeMux).ServeHTTP(0xc00011c1a0?, {0xe0a310, 0xc0001ce780}, 0xc0000fedc0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2861 +0x1c7 fp=0xc0001cdae0 sp=0xc0001cda90 pc=0x710fe7 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xe0a310, 0xc0001ce780}, 0xc0000fedc0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x164 fp=0xc0001cdb38 sp=0xc0001cdae0 pc=0xa25e84 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.HandlerFunc.ServeHTTP(0x485cb9?, {0xe0a310?, 0xc0001ce780?}, 0xc0001cdb68?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0001cdb60 sp=0xc0001cdb38 pc=0x70f109 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.serverHandler.ServeHTTP({0xc0000894c0?}, {0xe0a310?, 0xc0001ce780?}, 0x1?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:3340 +0x8e fp=0xc0001cdb90 sp=0xc0001cdb60 pc=0x72e58e Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*conn).serve(0xc0002485a0, {0xe0b260, 0xc0001284b0}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2109 +0x665 fp=0xc0001cdfb8 sp=0xc0001cdb90 pc=0x70d205 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Server).Serve.gowrap3() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:3493 +0x28 fp=0xc0001cdfe0 sp=0xc0001cdfb8 pc=0x712e08 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001cdfe8 sp=0xc0001cdfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by net/http.(*Server).Serve in goroutine 10 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:3493 +0x485 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 35 gp=0xc0000aba40 m=nil [select, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc000058740?, 0x5?, 0x89?, 0x6e?, 0xc0000586e6?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000058568 sp=0xc000058548 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc000058740, 0xc0000586dc, 0x486405?, 0x0, 0xaf6301?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0000586a8 sp=0xc000058568 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc0000ed380) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc0000587c8 sp=0xc0000586a8 pc=0x847556 Mar 26 08:27:17 volumio go-librespot[176925]: nhooyr.io/websocket.newConn.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc0000587e0 sp=0xc0000587c8 pc=0x847165 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000587e8 sp=0xc0000587e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by nhooyr.io/websocket.newConn in goroutine 16 Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 22 gp=0xc000103dc0 m=nil [GC worker (idle), 3 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x7d71639232ec?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005af38 sp=0xc00005af18 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkWorker(0xc0001437a0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00005afc8 sp=0xc00005af38 pc=0x43598b Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00005afe0 sp=0xc00005afc8 pc=0x435865 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005afe8 sp=0xc00005afe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcBgMarkStartWorkers in goroutine 19 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 23 gp=0xc00046c000 m=nil [GC worker (idle)]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x7d716394bb52?, 0x1?, 0xaa?, 0xc1?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000072f38 sp=0xc000072f18 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkWorker(0xc0001437a0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc000072fc8 sp=0xc000072f38 pc=0x43598b Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc000072fe0 sp=0xc000072fc8 pc=0x435865 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000072fe8 sp=0xc000072fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcBgMarkStartWorkers in goroutine 19 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 24 gp=0xc00046c1c0 m=nil [GC worker (idle), 921 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x4b5217741c9e?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00046af38 sp=0xc00046af18 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkWorker(0xc0001437a0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00046afc8 sp=0xc00046af38 pc=0x43598b Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00046afe0 sp=0xc00046afc8 pc=0x435865 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00046afe8 sp=0xc00046afe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by runtime.gcBgMarkStartWorkers in goroutine 19 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 321 gp=0xc00046c8c0 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc00040cb60?, 0x2?, 0x1?, 0x0?, 0xc00040cae4?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00040c968 sp=0xc00040c948 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc00040cb60, 0xc00040cae0, 0x4?, 0x0, 0x0?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00040caa8 sp=0xc00040c968 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: net.doBlockingWithCtx[...]({0xe0b298, 0xc000403720}, {0xc000152030, 0x13}, 0xc000384cf0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:71 +0x29a fp=0xc00040cbc0 sp=0xc00040caa8 pc=0x59bada Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupIP({0xe0b298, 0xc000403720}, {0xce44e8, 0x3}, {0xc000152030, 0x13}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:228 +0xa5 fp=0xc00040cc00 sp=0xc00040cbc0 pc=0x56de85 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIP(0x1460940, {0xe0b298, 0xc000403720}, {0xce44e8, 0x3}, {0xc000152030, 0x13}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup_unix.go:64 +0xe5 fp=0xc00040ce58 sp=0xc00040cc00 pc=0x588165 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIP-fm({0xe0b298?, 0xc000403720?}, {0xce44e8?, 0x421ba0?}, {0xc000152030?, 0x4?}) Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x49 fp=0xc00040cea0 sp=0xc00040ce58 pc=0x5a17a9 Mar 26 08:27:17 volumio go-librespot[176925]: net.init.func1({0xe0b298?, 0xc000403720?}, 0xc0002bde50?, {0xce44e8?, 0x3?}, {0xc000152030?, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/hook.go:21 +0x37 fp=0xc00040cee0 sp=0xc00040cea0 pc=0x56b517 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIPAddr.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup.go:335 +0x37 fp=0xc00040cf38 sp=0xc00040cee0 pc=0x587ab7 Mar 26 08:27:17 volumio go-librespot[176925]: internal/singleflight.(*Group).doCall(0x1460950, 0xc000403770, {0xc0004c8138, 0x17}, 0xd41a78?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x34 fp=0xc00040cfa8 sp=0xc00040cf38 pc=0x56a314 Mar 26 08:27:17 volumio go-librespot[176925]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x30 fp=0xc00040cfe0 sp=0xc00040cfa8 pc=0x56a2b0 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00040cfe8 sp=0xc00040cfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by internal/singleflight.(*Group).DoChan in goroutine 204 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x2cf Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 83 gp=0xc000002000 m=nil [select, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc00040ef20?, 0x3?, 0xb8?, 0xed?, 0xc00040eeda?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00040ed60 sp=0xc00040ed40 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc00040ef20, 0xc00040eed4, 0x0?, 0x0, 0x468980?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00040eea0 sp=0xc00040ed60 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0xc000416780) Mar 26 08:27:17 volumio go-librespot[176925]: /src/player/player.go:215 +0x205 fp=0xc00040efc8 sp=0xc00040eea0 pc=0x911e65 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/player/player.go:197 +0x25 fp=0xc00040efe0 sp=0xc00040efc8 pc=0x911a25 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00040efe8 sp=0xc00040efe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/player/player.go:197 +0x1e5 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 84 gp=0xc000102540 m=nil [select, 3 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc00038fed0?, 0xa?, 0x0?, 0x0?, 0xc00038f6c0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00038f318 sp=0xc00038f2f8 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc00038fed0, 0xc00038f6ac, 0x1483020?, 0x0, 0x1d?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00038f458 sp=0xc00038f318 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*AppPlayer).Run(0xc000182780, {0xe0b228, 0x1483020}, 0xc000406310, 0xc000406380) Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/player.go:661 +0x427 fp=0xc00038ffa8 sp=0xc00038f458 pc=0xa38667 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).withAppPlayer.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:274 +0x30 fp=0xc00038ffe0 sp=0xc00038ffa8 pc=0xa31430 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00038ffe8 sp=0xc00038ffe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:274 +0x3c5 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 85 gp=0xc0001028c0 m=nil [chan receive, 1206 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc0002c30e0?, 0xc0002c2060?, 0x0?, 0x0?, 0xc000466ef0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000466e98 sp=0xc000466e78 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.chanrecv(0xc000094310, 0xc000466f98, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000466f10 sp=0xc000466e98 pc=0x422773 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.chanrecv2(0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000466f38 sp=0xc000466f10 pc=0x4222f2 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).withAppPlayer.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:284 +0x72 fp=0xc000466fe0 sp=0xc000466f38 pc=0xa31372 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000466fe8 sp=0xc000466fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:281 +0x45f Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 86 gp=0xc000102a80 m=nil [chan receive, 1206 minutes]: Mar 26 08:27:17 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Mar 26 08:27:17 volumio volumio[1232]: info: Connection to go-librespot Websocket closed Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000467698 sp=0xc000467678 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.chanrecv(0xc0000942a0, 0xc0004677b8, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000467710 sp=0xc000467698 pc=0x422773 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.chanrecv2(0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000467738 sp=0xc000467710 pc=0x4222f2 Mar 26 08:27:17 volumio go-librespot[176925]: main.(*App).withAppPlayer.func2() Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:300 +0x87 fp=0xc0004677e0 sp=0xc000467738 pc=0xa30fa7 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004677e8 sp=0xc0004677e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/cmd/daemon/main.go:297 +0x51f Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 87 gp=0xc000102c40 m=nil [IO wait, 619 minutes]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00040fbe0 sp=0xc00040fbc0 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.netpollblock(0xc00040fc30?, 0x41f886?, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00040fc18 sp=0xc00040fbe0 pc=0x44d977 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.runtime_pollWait(0x7f4b31069600, 0x72) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00040fc38 sp=0xc00040fc18 pc=0x4880e5 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).wait(0xc000182300?, 0x900429897?, 0x0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00040fc60 sp=0xc00040fc38 pc=0x50a827 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*pollDesc).waitRead(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 08:27:17 volumio go-librespot[176925]: internal/poll.(*FD).Accept(0xc000182300) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00040fd08 sp=0xc00040fc60 pc=0x50fc4c Mar 26 08:27:17 volumio go-librespot[176925]: net.(*netFD).accept(0xc000182300) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00040fdc0 sp=0xc00040fd08 pc=0x57c449 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*TCPListener).accept(0xc00045a1c0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00040fe10 sp=0xc00040fdc0 pc=0x591bbb Mar 26 08:27:17 volumio go-librespot[176925]: net.(*TCPListener).Accept(0xc00045a1c0) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00040fe40 sp=0xc00040fe10 pc=0x590d90 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*onceCloseListener).Accept(0xc000178510?) Mar 26 08:27:17 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x24 fp=0xc00040fe58 sp=0xc00040fe40 pc=0x73aaa4 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Server).Serve(0xc0002d8200, {0xe0a190, 0xc00045a1c0}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00040ff88 sp=0xc00040fe58 pc=0x712a0c Mar 26 08:27:17 volumio go-librespot[176925]: net/http.Serve(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/server.go:2971 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Mar 26 08:27:17 volumio go-librespot[176925]: /src/zeroconf/zeroconf.go:280 +0x85 fp=0xc00040ffe0 sp=0xc00040ff88 pc=0x9a38a5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00040ffe8 sp=0xc00040ffe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Mar 26 08:27:17 volumio go-librespot[176925]: /src/zeroconf/zeroconf.go:280 +0x156 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 204 gp=0xc0000abdc0 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc000299620?, 0x2?, 0xc8?, 0x93?, 0xc0002994d8?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000299358 sp=0xc000299338 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc000299620, 0xc0002994d4, 0x17?, 0x0, 0x1?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000299498 sp=0xc000299358 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIPAddr(0x1460940, {0xe0b308, 0xc0000e4fc0}, {0xce44e8, 0x3}, {0xc000152030, 0x13}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup.go:343 +0x3d9 fp=0xc000299678 sp=0xc000299498 pc=0x5871f9 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).internetAddrList(0x1460940?, {0xe0b308?, 0xc0000e4fc0?}, {0xce44e8, 0x3}, {0xc000152030?, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/ipsock.go:289 +0x4b3 fp=0xc000299760 sp=0xc000299678 pc=0x5854f3 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).resolveAddrList(0x1460940, {0xe0b308, 0xc0000e4fc0}, {0xce48f8, 0x4}, {0xce44e8?, 0xc0002998c0?}, {0xc000152030, 0x18}, {0x0, ...}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/dial.go:353 +0x3e5 fp=0xc000299860 sp=0xc000299760 pc=0x570265 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Dialer).DialContext(0xc000299a08, {0xe0b308, 0xc0000e4fc0}, {0xce44e8, 0x3}, {0xc000152030, 0x18}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/dial.go:560 +0x3f7 fp=0xc0002999d0 sp=0xc000299860 pc=0x5710d7 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/proxy.direct.DialContext(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/proxy/direct.go:30 Mar 26 08:27:17 volumio systemd[1]: go-librespot-daemon.service: Consumed 7.676s CPU time. Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/proxy.(*direct).DialContext(0x13fc020?, {0xe0b308?, 0xc0000e4fc0?}, {0xce44e8?, 0xce7e94?}, {0xc000152030?, 0xc0002be290?}) Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x85 fp=0xc000299aa8 sp=0xc0002999d0 pc=0x8a1765 Mar 26 08:27:17 volumio go-librespot[176925]: golang.org/x/net/proxy.Dial({0xe0b308, 0xc0000e4fc0}, {0xce44e8, 0x3}, {0xc000152030, 0x18}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/golang.org/x/net@v0.48.0/proxy/dial.go:28 +0x98 fp=0xc000299b08 sp=0xc000299aa8 pc=0x89f658 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0xc0001ce960, {0xe0b228, 0x1483020}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:95 +0x248 fp=0xc000299be0 sp=0xc000299b08 pc=0x8a3e68 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0xc0001ce960, {0xe0b228, 0x1483020}, 0xc0003594a0) Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:205 +0xc8 fp=0xc000299c58 sp=0xc000299be0 pc=0x8a4f48 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0xc0001ce960) Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:394 +0xc7 fp=0xc000299ca8 sp=0xc000299c58 pc=0x8a6527 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x25 fp=0xc000299cc0 sp=0xc000299ca8 pc=0x8aa185 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x13 fp=0xc000299cd0 sp=0xc000299cc0 pc=0x899b73 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0xc000299df8?, {0xe08da8, 0xc000113980}, 0x0, {0x0, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0x11c fp=0xc000299dc0 sp=0xc000299cd0 pc=0x899f5c Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x0?, {0xe08da8?, 0xc000113980?}, 0x0?, {0x0?, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x56 fp=0xc000299e18 sp=0xc000299dc0 pc=0x899af6 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.Retry(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0xc0001ce960) Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:335 +0x451 fp=0xc000299fc8 sp=0xc000299e18 pc=0x8a5df1 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:403 +0x25 fp=0xc000299fe0 sp=0xc000299fc8 pc=0x8a6665 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000299fe8 sp=0xc000299fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 173 Mar 26 08:27:17 volumio go-librespot[176925]: /src/ap/ap.go:403 +0x108 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 386 gp=0xc00046d340 m=3 mp=0xc000063008 [syscall]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.cgocall(0xaa3d00, 0xc00040ae00) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/cgocall.go:167 +0x4b fp=0xc00040add8 sp=0xc00040ada0 pc=0x485deb Mar 26 08:27:17 volumio go-librespot[176925]: net._C2func_getaddrinfo(0xc0004c8180, 0x0, 0xc000384d50, 0xc000448068) Mar 26 08:27:17 volumio go-librespot[176925]: _cgo_gotypes.go:109 +0x50 fp=0xc00040ae00 sp=0xc00040add8 pc=0x598af0 Mar 26 08:27:17 volumio go-librespot[176925]: net._C_getaddrinfo.func1(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 26 08:27:17 volumio go-librespot[176925]: net._C_getaddrinfo(0xc0004c8180, 0x0, 0xc000384d50, 0xc000448068) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x7b fp=0xc00040ae48 sp=0xc00040ae00 pc=0x598e1b Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupHostIP({0xce44e8, 0x3}, {0xc000152030, 0x13}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:174 +0x1fd fp=0xc00040af50 sp=0xc00040ae48 pc=0x56d85d Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupIP.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:229 +0x25 fp=0xc00040af80 sp=0xc00040af50 pc=0x56df05 Mar 26 08:27:17 volumio go-librespot[176925]: net.doBlockingWithCtx[...].func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:67 +0x56 fp=0xc00040afe0 sp=0xc00040af80 pc=0x59bd96 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00040afe8 sp=0xc00040afe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by net.doBlockingWithCtx[...] in goroutine 321 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:64 +0x210 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 62 gp=0xc00046d880 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc00040bf98?, 0x2?, 0x40?, 0xc7?, 0xc00040bf44?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00040bdc8 sp=0xc00040bda8 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc00040bf98, 0xc00040bf40, 0x0?, 0x0, 0xc0003ca960?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00040bf08 sp=0xc00040bdc8 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0xc0004d0000) Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:138 +0x8f fp=0xc00040bfc8 sp=0xc00040bf08 pc=0x92e5cf Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap2() Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:129 +0x25 fp=0xc00040bfe0 sp=0xc00040bfc8 pc=0x92e4a5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00040bfe8 sp=0xc00040bfe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 84 Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:129 +0xf6 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 381 gp=0xc0001036c0 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc000411b60?, 0x2?, 0x1?, 0x0?, 0xc000411ae4?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000411968 sp=0xc000411948 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc000411b60, 0xc000411ae0, 0x4?, 0x0, 0x0?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000411aa8 sp=0xc000411968 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: net.doBlockingWithCtx[...]({0xe0b298, 0xc0000e8af0}, {0xc0002c81c0, 0x17}, 0xc0002bbe00) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:71 +0x29a fp=0xc000411bc0 sp=0xc000411aa8 pc=0x59bada Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupIP({0xe0b298, 0xc0000e8af0}, {0xce44e8, 0x3}, {0xc0002c81c0, 0x17}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:228 +0xa5 fp=0xc000411c00 sp=0xc000411bc0 pc=0x56de85 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIP(0x1460940, {0xe0b298, 0xc0000e8af0}, {0xce44e8, 0x3}, {0xc0002c81c0, 0x17}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup_unix.go:64 +0xe5 fp=0xc000411e58 sp=0xc000411c00 pc=0x588165 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIP-fm({0xe0b298?, 0xc0000e8af0?}, {0xce44e8?, 0x3?}, {0xc0002c81c0?, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x49 fp=0xc000411ea0 sp=0xc000411e58 pc=0x5a17a9 Mar 26 08:27:17 volumio go-librespot[176925]: net.init.func1({0xe0b298?, 0xc0000e8af0?}, 0xc0000e4850?, {0xce44e8?, 0x4213b7?}, {0xc0002c81c0?, 0xc000411f70?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/hook.go:21 +0x37 fp=0xc000411ee0 sp=0xc000411ea0 pc=0x56b517 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIPAddr.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup.go:335 +0x37 fp=0xc000411f38 sp=0xc000411ee0 pc=0x587ab7 Mar 26 08:27:17 volumio go-librespot[176925]: internal/singleflight.(*Group).doCall(0x1460950, 0xc0000e8b90, {0xc0002c81e0, 0x1b}, 0x0?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x34 fp=0xc000411fa8 sp=0xc000411f38 pc=0x56a314 Mar 26 08:27:17 volumio go-librespot[176925]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x30 fp=0xc000411fe0 sp=0xc000411fa8 pc=0x56a2b0 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000411fe8 sp=0xc000411fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by internal/singleflight.(*Group).DoChan in goroutine 380 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x2cf Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 301 gp=0xc000302000 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc0001c9de0?, 0x2?, 0x25?, 0x93?, 0xc0001c9d8c?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0001c9c10 sp=0xc0001c9bf0 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc0001c9de0, 0xc0001c9d88, 0xb52bc0?, 0x0, 0x429897?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0001c9d50 sp=0xc0001c9c10 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0xc0001c9e78?, {0xe08da8, 0xc00008b4a0}, 0x0, {0x0, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:112 +0x245 fp=0xc0001c9e40 sp=0xc0001c9d50 pc=0x89a085 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x0?, {0xe08da8?, 0xc00008b4a0?}, 0x0?, {0x0?, 0x0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x56 fp=0xc0001c9e98 sp=0xc0001c9e40 pc=0x899af6 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/cenkalti/backoff/v4.Retry(...) Mar 26 08:27:17 volumio go-librespot[176925]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0xc0004d0000) Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:237 +0x550 fp=0xc0001c9fc8 sp=0xc0001c9e98 pc=0x92ee70 Mar 26 08:27:17 volumio go-librespot[176925]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect.gowrap1() Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:296 +0x25 fp=0xc0001c9fe0 sp=0xc0001c9fc8 pc=0x92f485 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001c9fe8 sp=0xc0001c9fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect in goroutine 282 Mar 26 08:27:17 volumio go-librespot[176925]: /src/dealer/dealer.go:296 +0xea Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 380 gp=0xc0003021c0 m=nil [select]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.gopark(0xc0001c75c8?, 0x2?, 0x70?, 0x73?, 0xc0001c7480?) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0001c7300 sp=0xc0001c72e0 pc=0x488f0e Mar 26 08:27:17 volumio go-librespot[176925]: runtime.selectgo(0xc0001c75c8, 0xc0001c747c, 0x1b?, 0x0, 0x1?, 0x1) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0001c7440 sp=0xc0001c7300 pc=0x467bd7 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).lookupIPAddr(0x1460940, {0xe0b308, 0xc0004fa460}, {0xce44e8, 0x3}, {0xc0002c81c0, 0x17}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/lookup.go:343 +0x3d9 fp=0xc0001c7620 sp=0xc0001c7440 pc=0x5871f9 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).internetAddrList(0x1460940?, {0xe0b308?, 0xc0004fa460?}, {0xce44e8, 0x3}, {0xc0002c81c0?, 0xbe8ee0?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/ipsock.go:289 +0x4b3 fp=0xc0001c7708 sp=0xc0001c7620 pc=0x5854f3 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Resolver).resolveAddrList(0x1460940, {0xe0b308, 0xc0004fa460}, {0xce48f8, 0x4}, {0xce44e8?, 0x4ae3b9?}, {0xc0002c81c0, 0x1b}, {0x0, ...}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/dial.go:353 +0x3e5 fp=0xc0001c7808 sp=0xc0001c7708 pc=0x570265 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Dialer).DialContext(0xc0002481b0, {0xe0b298, 0xc0000e8aa0}, {0xce44e8, 0x3}, {0xc0002c81c0, 0x1b}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/dial.go:560 +0x3f7 fp=0xc0001c7978 sp=0xc0001c7808 pc=0x5710d7 Mar 26 08:27:17 volumio go-librespot[176925]: net.(*Dialer).DialContext-fm({0xe0b298?, 0xc0000e8aa0?}, {0xce44e8?, 0xcce220?}, {0xc0002c81c0?, 0xc0002b2a18?}) Mar 26 08:27:17 volumio go-librespot[176925]: :1 +0x49 fp=0xc0001c79c0 sp=0xc0001c7978 pc=0x73bba9 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Transport).dial(0xc0002d6c40?, {0xe0b298?, 0xc0000e8aa0?}, {0xce44e8?, 0xc0000e4fc0?}, {0xc0002c81c0?, 0xc000112900?}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/transport.go:1278 +0xd2 fp=0xc0001c7a28 sp=0xc0001c79c0 pc=0x721cf2 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Transport).dialConn(0x14090e0, {0xe0b298, 0xc0000e8aa0}, {{}, 0x0, {0xc000399860, 0x5}, {0xc0002c81c0, 0x1b}, 0x1}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/transport.go:1783 +0x7e5 fp=0xc0001c7ee0 sp=0xc0001c7a28 pc=0x724ca5 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Transport).dialConnFor(0x14090e0, 0xc00029c370) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/transport.go:1618 +0xb8 fp=0xc0001c7f90 sp=0xc0001c7ee0 pc=0x7237b8 Mar 26 08:27:17 volumio go-librespot[176925]: net/http.(*Transport).startDialConnForLocked.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/transport.go:1600 +0x35 fp=0xc0001c7fe0 sp=0xc0001c7f90 pc=0x7235f5 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001c7fe8 sp=0xc0001c7fe0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by net/http.(*Transport).startDialConnForLocked in goroutine 301 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/http/transport.go:1599 +0x112 Mar 26 08:27:17 volumio go-librespot[176925]: goroutine 382 gp=0xc000303880 m=0 mp=0x1463040 [syscall]: Mar 26 08:27:17 volumio go-librespot[176925]: runtime.cgocall(0xaa3d00, 0xc000059600) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/cgocall.go:167 +0x4b fp=0xc0000595d8 sp=0xc0000595a0 pc=0x485deb Mar 26 08:27:17 volumio go-librespot[176925]: net._C2func_getaddrinfo(0xc000152330, 0x0, 0xc0002bbe60, 0xc000482138) Mar 26 08:27:17 volumio go-librespot[176925]: _cgo_gotypes.go:109 +0x50 fp=0xc000059600 sp=0xc0000595d8 pc=0x598af0 Mar 26 08:27:17 volumio go-librespot[176925]: net._C_getaddrinfo.func1(...) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 26 08:27:17 volumio go-librespot[176925]: net._C_getaddrinfo(0xc000152330, 0x0, 0xc0002bbe60, 0xc000482138) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x7b fp=0xc000059648 sp=0xc000059600 pc=0x598e1b Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupHostIP({0xce44e8, 0x3}, {0xc0002c81c0, 0x17}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:174 +0x1fd fp=0xc000059750 sp=0xc000059648 pc=0x56d85d Mar 26 08:27:17 volumio go-librespot[176925]: net.cgoLookupIP.func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:229 +0x25 fp=0xc000059780 sp=0xc000059750 pc=0x56df05 Mar 26 08:27:17 volumio go-librespot[176925]: net.doBlockingWithCtx[...].func1() Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:67 +0x56 fp=0xc0000597e0 sp=0xc000059780 pc=0x59bd96 Mar 26 08:27:17 volumio go-librespot[176925]: runtime.goexit({}) Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000597e8 sp=0xc0000597e0 pc=0x490a41 Mar 26 08:27:17 volumio go-librespot[176925]: created by net.doBlockingWithCtx[...] in goroutine 381 Mar 26 08:27:17 volumio go-librespot[176925]: /usr/local/go/src/net/cgo_unix.go:64 +0x210 Mar 26 08:27:17 volumio go-librespot[176924]: Aborted Mar 26 08:27:17 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 26 08:27:20 volumio volumio[1232]: info: Initializing connection to go-librespot Websocket Mar 26 08:27:20 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Mar 26 08:27:20 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 08:27:20 volumio systemd[1]: go-librespot-daemon.service: Consumed 7.676s CPU time. Mar 26 08:27:20 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 08:27:20 volumio go-librespot[370214]: go-librespot daemon starting... Mar 26 08:27:20 volumio go-librespot[370215]: time="2026-03-26T08:27:20Z" level=info msg="running go-librespot 0.6.2" Mar 26 08:27:20 volumio go-librespot[370215]: time="2026-03-26T08:27:20Z" level=debug msg="app state loaded" Mar 26 08:27:20 volumio go-librespot[370215]: time="2026-03-26T08:27:20Z" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 08:27:21 volumio go-librespot[370215]: time="2026-03-26T08:27:21Z" level=debug msg="new websocket client" Mar 26 08:27:21 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 26 08:27:21 volumio volumio[1232]: info: Connection to go-librespot Websocket established Mar 26 08:27:21 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Mar 26 08:27:21 volumio volumio[1232]: info: CorePlayQueue::getTrack 1 Mar 26 08:27:21 volumio volumiossh-tunnel[370154]: ssh: Could not resolve hostname eu3.myvolumio.org: Device or resource busy Mar 26 08:27:21 volumio autossh[370151]: ssh exited prematurely with status 255; autossh exiting Mar 26 08:27:21 volumio systemd[1]: sshtunnel.service: Main process exited, code=exited, status=1/FAILURE Mar 26 08:27:21 volumio systemd[1]: sshtunnel.service: Failed with result 'exit-code'. Mar 26 08:27:22 volumio systemd[1]: sshtunnel.service: Scheduled restart job, restart counter is at 1. Mar 26 08:27:22 volumio systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:27:22 volumio systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Mar 26 08:27:22 volumio autossh[370226]: port set to 0, monitoring disabled Mar 26 08:27:22 volumio autossh[370226]: starting ssh (count 1) Mar 26 08:27:22 volumio autossh[370226]: ssh child pid is 370229 Mar 26 08:27:24 volumio volumio[1232]: info: Getting Spotify volume Mar 26 08:27:24 volumio volumio[1232]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Mar 26 08:27:24 volumio volumio[1232]: info: CoreCommandRouter::volumioGetState Mar 26 08:27:24 volumio volumio[1232]: info: CorePlayQueue::getTrack 1 Mar 26 08:27:24 volumio volumio[1232]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Mar 26 08:27:24 volumio volumio[1232]: SPOTIFY: SPOTIFY VOLUME 100 Mar 26 08:27:24 volumio volumio[1232]: SPOTIFY: VOLUMIO VOLUME 100 Mar 26 08:27:24 volumio volumio[1232]: SPOTIFY: DELTA VOLUME ENOUGH: false Mar 26 08:27:48 volumio go-librespot[370215]: time="2026-03-26T08:27:48Z" 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" Mar 26 08:27:48 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 08:27:48 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 08:27:48 volumio volumio[1232]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 08:27:48 volumio volumio[1232]: Error: socket hang up Mar 26 08:27:48 volumio volumio[1232]: at connResetException (node:internal/errors:720:14) Mar 26 08:27:48 volumio volumio[1232]: at Socket.socketOnEnd (node:_http_client:519:23) Mar 26 08:27:48 volumio volumio[1232]: at Socket.emit (node:events:526:35) Mar 26 08:27:48 volumio volumio[1232]: at endReadableNT (node:internal/streams/readable:1376:12) Mar 26 08:27:48 volumio volumio[1232]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 26 08:27:48 volumio volumio[1232]: code: 'ECONNRESET', Mar 26 08:27:48 volumio volumio[1232]: response: undefined Mar 26 08:27:48 volumio volumio[1232]: } Mar 26 08:27:48 volumio volumio[1232]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 08:27:49 volumio sudo[370319]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 08:26' Mar 26 08:27:49 volumio sudo[370319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 17:11:42 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="21a5161aef4cb85a1f93b140ccadc4f1"