Mar 25 01:30:03 volumio go-librespot[6175]: time="2026-03-25T01:30:03+01:00" level=debug msg="renewing login5 access token" Mar 25 01:30:08 volumio go-librespot[6175]: time="2026-03-25T01:30:08+01:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:80, retrying with a different AP" error="dial tcp: lookup ap-gae2.spotify.com: device or resource busy" Mar 25 01:30:20 volumio go-librespot[6175]: time="2026-03-25T01:30:20+01:00" level=error msg="did not receive last pong from dealer, 210s passed" Mar 25 01:30:28 volumio go-librespot[6175]: time="2026-03-25T01:30:28+01:00" level=debug msg="renewing login5 access token" Mar 25 01:30:30 volumio go-librespot[6175]: time="2026-03-25T01:30:30+01:00" 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 25 01:30:38 volumio go-librespot[6175]: time="2026-03-25T01:30:38+01:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew4.spotify.com: i/o timeout" Mar 25 01:30:50 volumio go-librespot[6175]: time="2026-03-25T01:30:50+01:00" level=error msg="did not receive last pong ack from accesspoint, 304s passed" Mar 25 01:30:50 volumio go-librespot[6175]: panic: runtime error: invalid memory address or nil pointer dereference Mar 25 01:30:50 volumio go-librespot[6175]: [signal SIGSEGV: segmentation violation code=0x1 addr=0xc pc=0x4f6f14] Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821865 gp=0x23a4488 m=5 mp=0x1c7a008 [running]: Mar 25 01:30:50 volumio go-librespot[6175]: panic({0x82e098, 0xf78250}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x2117f20 sp=0x2117ecc pc=0xa92ec Mar 25 01:30:50 volumio go-librespot[6175]: runtime.panicmem(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/panic.go:262 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.sigpanic() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x2117f50 sp=0x2117f20 pc=0xabca4 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x1e99348) Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:380 +0x284 fp=0x2117fe4 sp=0x2117f54 pc=0x4f6f14 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:277 +0x28 fp=0x2117fec sp=0x2117fe4 pc=0x4f63e8 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2117fec sp=0x2117fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 14821845 Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:277 +0x15c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 1 gp=0x1c02128 m=nil [select, 5266 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2119ce8 sp=0x2119cd4 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x2119df8, 0x1cafdc4, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2119d98 sp=0x2119ce8 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x1d1e360, 0x2119e90) Mar 25 01:30:50 volumio go-librespot[6175]: /src/zeroconf/zeroconf.go:283 +0x21c fp=0x2119e3c sp=0x2119d98 pc=0x61db0c Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).withAppPlayer(0x1cb2200, {0xa260ac, 0xfdcff0}, 0x1d2cab0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:340 +0x580 fp=0x2119ed0 sp=0x2119e3c pc=0x6ab088 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).withCredentials(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:209 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).SpotifyToken(0x1cb2200, {0xa260ac, 0xfdcff0}, {0x1d1afd0, 0xa}, {0x1d203c0, 0x124}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x2119f00 sp=0x2119ed0 pc=0x6aa4b0 Mar 25 01:30:50 volumio go-librespot[6175]: main.main() Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:593 +0x660 fp=0x2119fa8 sp=0x2119f00 pc=0x6ad58c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.main() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x2119fec sp=0x2119fa8 pc=0x6f390 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2119fec sp=0x2119fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 2 gp=0x1c027e8 m=nil [force gc (idle), 2 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960edc, 0xfd0f08, 0x11, 0xa, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c48fd4 sp=0x1c48fc0 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goparkunlock(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:466 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.forcegchelper() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x1c48fec sp=0x1c48fd4 pc=0x6f7f4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c48fec sp=0x1c48fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.init.6 in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:361 +0x1c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 3 gp=0x1c02d88 m=nil [GC sweep wait]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960edc, 0xfd17b0, 0xc, 0x9, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c497c4 sp=0x1c497b0 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goparkunlock(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:466 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.bgsweep(0x1c2e050) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x1c497e4 sp=0x1c497c4 pc=0x5768c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcenable.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x1c497ec sp=0x1c497e4 pc=0x46c3c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c497ec sp=0x1c497ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcenable in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 4 gp=0x1c02ea8 m=nil [GC scavenge wait]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960edc, 0xfd20d0, 0xd, 0xa, 0x2) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c49fb4 sp=0x1c49fa0 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goparkunlock(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:466 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.(*scavengerState).park(0xfd20d0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1c49fc8 sp=0x1c49fb4 pc=0x54a28 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.bgscavenge(0x1c2e050) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1c49fe4 sp=0x1c49fc8 pc=0x5516c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcenable.gowrap2() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x1c49fec sp=0x1c49fe4 pc=0x46be8 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c49fec sp=0x1c49fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcenable in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 18 gp=0x1d08008 m=nil [GOMAXPROCS updater (idle), 12328 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960edc, 0xfd1548, 0x12, 0xa, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c447a4 sp=0x1c44790 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goparkunlock(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:466 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.updateMaxProcsGoroutine() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x1c447ec sp=0x1c447a4 pc=0x7f174 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c447ec sp=0x1c447ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 19 gp=0x1d08368 m=nil [finalizer wait, 5263 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d84, 0xfdd0e0, 0x10, 0xa, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c44f88 sp=0x1c44f74 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.runFinalizers() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x1c44fec sp=0x1c44f88 pc=0x45888 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c44fec sp=0x1c44fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.createfing in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 20 gp=0x1de98c8 m=nil [cleanup wait, 977 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960edc, 0xfd22a8, 0x2e, 0xa, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c487a4 sp=0x1c48790 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goparkunlock(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:466 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.(*cleanupQueue).dequeue(0xfd2248) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x1c487c4 sp=0x1c487a4 pc=0x41cb0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.runCleanups() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x1c487ec sp=0x1c487c4 pc=0x4284c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c487ec sp=0x1c487ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 36 gp=0x1c8a908 m=nil [IO wait]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960ecc, 0xb607b810, 0x2, 0x2, 0x5) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x211be88 sp=0x211be74 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.netpollblock(0xb607b800, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x211bea0 sp=0x211be88 pc=0x675a0 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.runtime_pollWait(0xb607b800, 0x72) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x211beb4 sp=0x211bea0 pc=0xa8864 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).wait(0x1ebe0b8, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x211bec8 sp=0x211beb4 pc=0x134df4 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).waitRead(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*FD).RawRead(0x1ebe0a0, 0x20873b0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x154 fp=0x211bef4 sp=0x211bec8 pc=0x13a168 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*rawConn).Read(0x1c32338, 0x20873b0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x211bf14 sp=0x211bef4 pc=0x1bc9b4 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x1e84140, 0x2087380, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x140 fp=0x211bf44 sp=0x211bf14 pc=0x5b7e28 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x1e860c8, {0x1f80000, 0x10000, 0x10000}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x1a0 fp=0x211bf9c sp=0x211bf44 pc=0x5bbb1c Mar 25 01:30:50 volumio go-librespot[6175]: github.com/grandcat/zeroconf.(*Server).recv4(0x1f02540, 0x1e860c0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xdc fp=0x211bfe0 sp=0x211bf9c pc=0x618bf8 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x211bfec sp=0x211bfe0 pc=0x6188c8 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x211bfec sp=0x211bfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 27 Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 37 gp=0x1c8aa28 m=nil [IO wait, 12328 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960ecc, 0xb607b610, 0x2, 0x2, 0x5) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1cd4660 sp=0x1cd464c pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.netpollblock(0xb607b600, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1cd4678 sp=0x1cd4660 pc=0x675a0 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.runtime_pollWait(0xb607b600, 0x72) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1cd468c sp=0x1cd4678 pc=0xa8864 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).wait(0x1ebe108, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1cd46a0 sp=0x1cd468c pc=0x134df4 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).waitRead(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*FD).RawRead(0x1ebe0f0, 0x2019200) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x154 fp=0x1cd46cc sp=0x1cd46a0 pc=0x13a168 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*rawConn).Read(0x1c32360, 0x2019200) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1cd46ec sp=0x1cd46cc pc=0x1bc9b4 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x1e84150, 0x20191d0, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x140 fp=0x1cd471c sp=0x1cd46ec pc=0x5b7e28 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 25 01:30:50 volumio go-librespot[6175]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x1e860f8, {0x213c000, 0x10000, 0x10000}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x188 fp=0x1cd479c sp=0x1cd471c pc=0x5bf588 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/grandcat/zeroconf.(*Server).recv6(0x1f02540, 0x1e860f0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xdc fp=0x1cd47e0 sp=0x1cd479c pc=0x618ddc Mar 25 01:30:50 volumio go-librespot[6175]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x1cd47ec sp=0x1cd47e0 pc=0x61886c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1cd47ec sp=0x1cd47ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 27 Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 21 gp=0x1e32008 m=nil [IO wait, 5266 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960ecc, 0xb607be10, 0x2, 0x2, 0x5) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c5bcf0 sp=0x1c5bcdc pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.netpollblock(0xb607be00, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1c5bd08 sp=0x1c5bcf0 pc=0x675a0 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.runtime_pollWait(0xb607be00, 0x72) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1c5bd1c sp=0x1c5bd08 pc=0xa8864 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).wait(0x1d250f8, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1c5bd30 sp=0x1c5bd1c pc=0x134df4 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).waitRead(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*FD).Accept(0x1d250e0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1c5bd78 sp=0x1c5bd30 pc=0x1395b0 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*netFD).accept(0x1d250e0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1c5bde0 sp=0x1c5bd78 pc=0x1aa9d8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*TCPListener).accept(0x1d303c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1c5be34 sp=0x1c5bde0 pc=0x1c2304 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*TCPListener).Accept(0x1d303c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1c5be50 sp=0x1c5be34 pc=0x1c134c Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*onceCloseListener).Accept(0x1c760a0) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x34 fp=0x1c5be68 sp=0x1c5be50 pc=0x367710 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Server).Serve(0x1e8e008, {0xa258a8, 0x1d303c0}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1c5bf00 sp=0x1c5be68 pc=0x3408c8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.Serve(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2971 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*ConcreteApiServer).serve(0x1ca4120) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x1c5bfe4 sp=0x1c5bf00 pc=0x69fdac Mar 25 01:30:50 volumio go-librespot[6175]: main.NewApiServer.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x1c5bfec sp=0x1c5bfe4 pc=0x69eae4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c5bfec sp=0x1c5bfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by main.NewApiServer in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/api_server.go:332 +0x310 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 52 gp=0x1f08128 m=nil [GC worker (idle), 431 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d90, 0x1f72400, 0x1c, 0xa, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2067788 sp=0x2067774 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkWorker(0x1ff45c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x20677e4 sp=0x2067788 pc=0x49f34 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x20677ec sp=0x20677e4 pc=0x49e14 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x20677ec sp=0x20677ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 53 gp=0x1f08248 m=nil [GC worker (idle), 431 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d90, 0x1f72600, 0x1c, 0xa, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2989f88 sp=0x2989f74 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkWorker(0x1ff45c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2989fe4 sp=0x2989f88 pc=0x49f34 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2989fec sp=0x2989fe4 pc=0x49e14 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2989fec sp=0x2989fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 54 gp=0x1f08368 m=nil [GC worker (idle), 431 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d90, 0x1f72800, 0x1c, 0xa, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2062f88 sp=0x2062f74 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkWorker(0x1ff45c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2062fe4 sp=0x2062f88 pc=0x49f34 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2062fec sp=0x2062fe4 pc=0x49e14 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2062fec sp=0x2062fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 55 gp=0x1f08488 m=nil [GC worker (idle), 2 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d90, 0x1f72a00, 0x1c, 0xa, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x20c8f88 sp=0x20c8f74 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkWorker(0x1ff45c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x20c8fe4 sp=0x20c8f88 pc=0x49f34 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x20c8fec sp=0x20c8fe4 pc=0x49e14 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x20c8fec sp=0x20c8fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 41 gp=0x1c8a248 m=nil [IO wait, 12328 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960ecc, 0xb607b010, 0x2, 0x2, 0x5) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ca98d4 sp=0x1ca98c0 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.netpollblock(0xb607b000, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1ca98ec sp=0x1ca98d4 pc=0x675a0 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.runtime_pollWait(0xb607b000, 0x72) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1ca9900 sp=0x1ca98ec pc=0xa8864 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).wait(0x1efa568, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ca9914 sp=0x1ca9900 pc=0x134df4 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).waitRead(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*FD).Read(0x1efa550, {0x1eb6000, 0x1000, 0x1000}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1ca995c sp=0x1ca9914 pc=0x135f74 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*netFD).Read(0x1efa550, {0x1eb6000, 0x1000, 0x1000}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1ca9988 sp=0x1ca995c pc=0x1a8c28 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*conn).Read(0x1c322e8, {0x1eb6000, 0x1000, 0x1000}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1ca99b4 sp=0x1ca9988 pc=0x1b842c Mar 25 01:30:50 volumio go-librespot[6175]: io.(*multiReader).Read(0x20100c0, {0x1eb6000, 0x1000, 0x1000}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x1ca99e0 sp=0x1ca99b4 pc=0xef364 Mar 25 01:30:50 volumio go-librespot[6175]: bufio.(*Reader).fill(0x1e866c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x1ca9a04 sp=0x1ca99e0 pc=0x2b6390 Mar 25 01:30:50 volumio go-librespot[6175]: bufio.(*Reader).ReadByte(0x1e866c0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x1ca9a10 sp=0x1ca9a04 pc=0x2b6c0c Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.readFrameHeader(0x1e866c0, {0x1cccb7c, 0x8, 0x8}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x68 fp=0x1ca9a50 sp=0x1ca9a10 pc=0x498164 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x1cccb48, {0xa26090, 0xfdcff0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xb4 fp=0x1ca9b10 sp=0x1ca9a50 pc=0x49b01c Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).readLoop(0x1cccb48, {0xa26090, 0xfdcff0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x3c fp=0x1ca9bd4 sp=0x1ca9b10 pc=0x49ab08 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).reader(0x1cccb48, {0xa26090, 0xfdcff0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0xec fp=0x1ca9c58 sp=0x1ca9bd4 pc=0x49bc20 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).Reader(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).Read(0x1cccb48, {0xa26090, 0xfdcff0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x30 fp=0x1ca9c80 sp=0x1ca9c58 pc=0x49a0a0 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*ConcreteApiServer).serve.func17({0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/api_server.go:636 +0x3b0 fp=0x1ca9cfc sp=0x1ca9c80 pc=0x6a062c Mar 25 01:30:50 volumio go-librespot[6175]: net/http.HandlerFunc.ServeHTTP(0x1c321a8, {0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1ca9d0c sp=0x1ca9cfc pc=0x33cf4c Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*ServeMux).ServeHTTP(0x1c7c000, {0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x1ca9d4c sp=0x1ca9d0c pc=0x33ee3c Mar 25 01:30:50 volumio go-librespot[6175]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x1ca9d74 sp=0x1ca9d4c pc=0x69ffa8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.HandlerFunc.ServeHTTP(0x1c10170, {0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1ca9d84 sp=0x1ca9d74 pc=0x33cf4c Mar 25 01:30:50 volumio go-librespot[6175]: net/http.serverHandler.ServeHTTP({0x1e8e008}, {0xa25968, 0x1e98848}, 0x1e986e8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x1ca9da0 sp=0x1ca9d84 pc=0x35c2b8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*conn).serve(0x1d1ec00, {0xa260c8, 0x1c281f8}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x1ca9fdc sp=0x1ca9da0 pc=0x33b008 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Server).Serve.gowrap3() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x1ca9fec sp=0x1ca9fdc pc=0x340d40 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ca9fec sp=0x1ca9fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net/http.(*Server).Serve in goroutine 21 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:3493 +0x42c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 82 gp=0x1c8a5a8 m=nil [select, 5251 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1cd6e94 sp=0x1cd6e80 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1cd6fa8, 0x1cd6f6c, 0x0, 0x0, 0x5, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1cd6f44 sp=0x1cd6e94 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x1cccb48) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x144 fp=0x1cd6fe4 sp=0x1cd6f44 pc=0x494d20 Mar 25 01:30:50 volumio go-librespot[6175]: nhooyr.io/websocket.newConn.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x28 fp=0x1cd6fec sp=0x1cd6fe4 pc=0x4949b0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1cd6fec sp=0x1cd6fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by nhooyr.io/websocket.newConn in goroutine 41 Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x578 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 98 gp=0x1c8b0e8 m=nil [chan receive, 5266 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d64, 0x1cc40b8, 0xe, 0x7, 0x2) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c4573c sp=0x1c45728 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chanrecv(0x1cc4080, 0x1c457d0, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1c45784 sp=0x1c4573c pc=0x3414c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chanrecv2(0x1cc4080, 0x1c457d0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x1c45798 sp=0x1c45784 pc=0x33bf0 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).withAppPlayer.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:284 +0x68 fp=0x1c457ec sp=0x1c45798 pc=0x6abd40 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c457ec sp=0x1c457ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by main.(*App).withAppPlayer in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:281 +0x49c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 99 gp=0x1c8b208 m=nil [chan receive, 5251 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d64, 0x1cc4078, 0xe, 0x7, 0x2) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x229af40 sp=0x229af2c pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chanrecv(0x1cc4040, 0x1caffe0, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x229af88 sp=0x229af40 pc=0x3414c Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chanrecv2(0x1cc4040, 0x1caffe0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x229af9c sp=0x229af88 pc=0x33bf0 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).withAppPlayer.func2() Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:300 +0x6c fp=0x229afec sp=0x229af9c pc=0x6ab8a4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x229afec sp=0x229afec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by main.(*App).withAppPlayer in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:297 +0x53c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 100 gp=0x1c8b328 m=nil [IO wait, 279 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960ecc, 0xb607ba10, 0x2, 0x2, 0x5) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c465ac sp=0x1c46598 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.netpollblock(0xb607ba00, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1c465c4 sp=0x1c465ac pc=0x675a0 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.runtime_pollWait(0xb607ba00, 0x72) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1c465d8 sp=0x1c465c4 pc=0xa8864 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).wait(0x1ebe068, 0x72, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1c465ec sp=0x1c465d8 pc=0x134df4 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*pollDesc).waitRead(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 25 01:30:50 volumio go-librespot[6175]: internal/poll.(*FD).Accept(0x1ebe050) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1c46634 sp=0x1c465ec pc=0x1395b0 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*netFD).accept(0x1ebe050) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1c4669c sp=0x1c46634 pc=0x1aa9d8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*TCPListener).accept(0x1e86060) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1c466f0 sp=0x1c4669c pc=0x1c2304 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*TCPListener).Accept(0x1e86060) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1c4670c sp=0x1c466f0 pc=0x1c134c Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*onceCloseListener).Accept(0x1f11cc0) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x34 fp=0x1c46724 sp=0x1c4670c pc=0x367710 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Server).Serve(0x1e98e78, {0xa258a8, 0x1e86060}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1c467bc sp=0x1c46724 pc=0x3408c8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.Serve(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/server.go:2971 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Mar 25 01:30:50 volumio go-librespot[6175]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x1c467ec sp=0x1c467bc pc=0x61dc08 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c467ec sp=0x1c467ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Mar 25 01:30:50 volumio go-librespot[6175]: /src/zeroconf/zeroconf.go:280 +0x154 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822043 gp=0x1ca2248 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c5d86c sp=0x1c5d858 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1c5d9dc, 0x1c5d948, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1c5d91c sp=0x1c5d86c pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIPAddr(0xfd1660, {0xa2611c, 0x351c320}, {0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup.go:343 +0x394 fp=0x1c5da24 sp=0x1c5d91c pc=0x1b68b0 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).internetAddrList(0xfd1660, {0xa2611c, 0x351c320}, {0x903a4e, 0x3}, {0x1c9e760, 0x19}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/ipsock.go:289 +0x6b0 fp=0x1c5dab8 sp=0x1c5da24 pc=0x1b486c Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).resolveAddrList(0xfd1660, {0xa2611c, 0x351c320}, {0x903e50, 0x4}, {0x903a4e, 0x3}, {0x1c9e760, 0x19}, {0x0, ...}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/dial.go:353 +0x510 fp=0x1c5db40 sp=0x1c5dab8 pc=0x19f1a8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Dialer).DialContext(0x1e127e0, {0xa260e4, 0x2086cc0}, {0x903a4e, 0x3}, {0x1c9e760, 0x19}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/dial.go:560 +0x43c fp=0x1c5dc3c sp=0x1c5db40 pc=0x1a00e4 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Dialer).DialContext-fm({0xa260e4, 0x2086cc0}, {0x903a4e, 0x3}, {0x1c9e760, 0x19}) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x58 fp=0x1c5dc6c sp=0x1c5dc3c pc=0x368914 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dial(0xf812a8, {0xa260e4, 0x2086cc0}, {0x903a4e, 0x3}, {0x1c9e760, 0x19}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1278 +0x158 fp=0x1c5dcac sp=0x1c5dc6c pc=0x3506d4 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dialConn(0xf812a8, {0xa260e4, 0x2086cc0}, {{}, 0x0, {0x917af4, 0x5}, {0x1c9e760, 0x19}, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1783 +0x6a4 fp=0x1c5df60 sp=0x1c5dcac pc=0x3530b0 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dialConnFor(0xf812a8, 0x1f93200) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1618 +0x80 fp=0x1c5dfc4 sp=0x1c5df60 pc=0x351e80 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).startDialConnForLocked.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1600 +0x3c fp=0x1c5dfec sp=0x1c5dfc4 pc=0x351d08 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c5dfec sp=0x1c5dfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net/http.(*Transport).startDialConnForLocked in goroutine 14821940 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1599 +0x134 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822040 gp=0x1cda128 m=0 mp=0xfd2c30 [syscall]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.cgocall(0x74cab0, 0x21656fc) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/cgocall.go:167 +0x50 fp=0x21656e4 sp=0x21656cc pc=0xa628c Mar 25 01:30:50 volumio go-librespot[6175]: net._C2func_getaddrinfo(0x1d40c30, 0x0, 0x3948d20, 0x324c3b0) Mar 25 01:30:50 volumio go-librespot[6175]: _cgo_gotypes.go:105 +0x44 fp=0x21656f8 sp=0x21656e4 pc=0x1c97c8 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo.func1(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo(0x1d40c30, 0x0, 0x3948d20, 0x324c3b0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x80 fp=0x2165718 sp=0x21656f8 pc=0x1c9a8c Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupHostIP({0x903a4e, 0x3}, {0x1c2d8d8, 0x13}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:174 +0x1f4 fp=0x216578c sp=0x2165718 pc=0x19bd90 Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupIP.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:229 +0x34 fp=0x21657b4 sp=0x216578c pc=0x19c3b4 Mar 25 01:30:50 volumio go-librespot[6175]: net.doBlockingWithCtx[...].func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:67 +0x54 fp=0x21657ec sp=0x21657b4 pc=0x1cc878 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x21657ec sp=0x21657ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net.doBlockingWithCtx[...] in goroutine 14822039 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:64 +0x204 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821940 gp=0x1ce8008 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x211650c sp=0x21164f8 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x211666c, 0x21165e4, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x21165bc sp=0x211650c pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).getConn(0xf812a8, 0x2086c90, {{}, 0x0, {0x917af4, 0x5}, {0x1c9e760, 0x19}, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1523 +0x370 fp=0x21166b8 sp=0x21165bc pc=0x351440 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).roundTrip(0xf812a8, 0x1ce69a8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:685 +0x978 fp=0x21167a4 sp=0x21166b8 pc=0x34d528 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).RoundTrip(0xf812a8, 0x1ce69a8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/roundtrip.go:33 +0x2c fp=0x21167bc sp=0x21167a4 pc=0x35ba84 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.send(0x1ce6798, {0xa21b28, 0xf812a8}, {0xc268e913158a86c1, 0x2a0d15a5f6dab, 0xfd1e68}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:259 +0x53c fp=0x21168e8 sp=0x21167bc pc=0x2ed3ec Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).send(0x1c8c2c0, 0x1ce6798, {0xc268e913158a86c1, 0x2a0d15a5f6dab, 0xfd1e68}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:180 +0x98 fp=0x211692c sp=0x21168e8 pc=0x2eccd8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).do(0x1c8c2c0, 0x1ce6798) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:729 +0x9a8 fp=0x2116a3c sp=0x211692c pc=0x2ef340 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).Do(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:587 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).fetchUrls(0x1c880f0, {0xa2611c, 0x351c1e0}, {0x2116cb0, 0x1, 0x1}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/apresolve/resolve.go:83 +0x4d0 fp=0x2116c74 sp=0x2116a3c pc=0x597990 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).get(0x1c880f0, {0xa2611c, 0x351c1e0}, {0x907726, 0xb}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/apresolve/resolve.go:126 +0x84 fp=0x2116cbc sp=0x2116c74 pc=0x598514 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).getFunc.func1({0xa2611c, 0x351c1e0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/apresolve/resolve.go:157 +0x90 fp=0x2116d08 sp=0x2116cbc pc=0x598918 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0x1e99348, {0xa260ac, 0xfdcff0}) Mar 25 01:30:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Mar 25 01:30:50 volumio volumio[5988]: info: Connection to go-librespot Websocket closed Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:94 +0x26c fp=0x2116d80 sp=0x2116d08 pc=0x4f4938 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0x1e99348, {0xa260ac, 0xfdcff0}, 0x1e227b0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:205 +0xd4 fp=0x2116de4 sp=0x2116d80 pc=0x4f5a7c Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0x1e99348) Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:394 +0xcc fp=0x2116e0c sp=0x2116de4 pc=0x4f703c Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x28 fp=0x2116e1c sp=0x2116e0c pc=0x4fb294 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x1c fp=0x2116e28 sp=0x2116e1c pc=0x4ea1ec Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x2116ecc, {0xa24f50, 0x1c2aba0}, 0x0, {0x0, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0xcc fp=0x2116ea4 sp=0x2116e28 pc=0x4ea668 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x2116f5c, {0xa24f50, 0x1c2aba0}, 0x0, {0x0, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x5c fp=0x2116ed4 sp=0x2116ea4 pc=0x4ea1a4 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.Retry(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1e99348) Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:335 +0x434 fp=0x2116fe4 sp=0x2116ed4 pc=0x4f689c Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:403 +0x28 fp=0x2116fec sp=0x2116fe4 pc=0x4f71f0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2116fec sp=0x2116fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 14821921 Mar 25 01:30:50 volumio go-librespot[6175]: /src/ap/ap.go:403 +0x120 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821867 gp=0x2feec68 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c56e84 sp=0x1c56e70 pc=0xa97c0 Mar 25 01:30:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1c56fd4, 0x1c56f5c, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1c56f34 sp=0x1c56e84 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x1d7ebb8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:138 +0x8c fp=0x1c56fe4 sp=0x1c56f34 pc=0x5a0cfc Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:129 +0x28 fp=0x1c56fec sp=0x1c56fe4 pc=0x5a2c40 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c56fec sp=0x1c56fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 14821845 Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:129 +0x15c Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822045 gp=0x327e7e8 m=9 mp=0x1d0d008 [syscall]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.cgocall(0x74cab0, 0x298befc) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/cgocall.go:167 +0x50 fp=0x298bee4 sp=0x298becc pc=0xa628c Mar 25 01:30:50 volumio go-librespot[6175]: net._C2func_getaddrinfo(0x1d41038, 0x0, 0x39494c0, 0x324c538) Mar 25 01:30:50 volumio go-librespot[6175]: _cgo_gotypes.go:105 +0x44 fp=0x298bef8 sp=0x298bee4 pc=0x1c97c8 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo.func1(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo(0x1d41038, 0x0, 0x39494c0, 0x324c538) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x80 fp=0x298bf18 sp=0x298bef8 pc=0x1c9a8c Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupHostIP({0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:174 +0x1f4 fp=0x298bf8c sp=0x298bf18 pc=0x19bd90 Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupIP.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:229 +0x34 fp=0x298bfb4 sp=0x298bf8c pc=0x19c3b4 Mar 25 01:30:50 volumio go-librespot[6175]: net.doBlockingWithCtx[...].func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:67 +0x54 fp=0x298bfec sp=0x298bfb4 pc=0x1cc878 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x298bfec sp=0x298bfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net.doBlockingWithCtx[...] in goroutine 14822044 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:64 +0x204 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821845 gp=0x21306c8 m=nil [select, 275 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1cad930 sp=0x1cad91c pc=0xa97c0 Mar 25 01:30:50 volumio systemd[1]: go-librespot-daemon.service: Consumed 31min 21.770s CPU time. Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1cadf70, 0x1cadb20, 0x0, 0x0, 0xa, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1cad9e0 sp=0x1cad930 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*AppPlayer).Run(0x351cd20, {0xa260ac, 0xfdcff0}, 0x1f14800, 0x1f14840) Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/player.go:661 +0x368 fp=0x1cadfd4 sp=0x1cad9e0 pc=0x6b3970 Mar 25 01:30:50 volumio go-librespot[6175]: main.(*App).withAppPlayer.func2.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:328 +0x48 fp=0x1cadfec sp=0x1cadfd4 pc=0x6abcac Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1cadfec sp=0x1cadfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by main.(*App).withAppPlayer.func2 in goroutine 99 Mar 25 01:30:50 volumio go-librespot[6175]: /src/cmd/daemon/main.go:328 +0x2f0 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822012 gp=0x2132908 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2118b60 sp=0x2118b4c pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x2118c68, 0x2118c38, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2118c10 sp=0x2118b60 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net.doBlockingWithCtx[...]({0xa260e4, 0x2081530}, {0x1e2e3d8, 0x12}, 0x1c28720) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:71 +0x280 fp=0x2118c90 sp=0x2118c10 pc=0x1cc630 Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupIP({0xa260e4, 0x2081530}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:228 +0x98 fp=0x2118cc0 sp=0x2118c90 pc=0x19c334 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIP(0xfd1660, {0xa260e4, 0x2081530}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup_unix.go:64 +0x90 fp=0x2118efc sp=0x2118cc0 pc=0x1b7a0c Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIP-fm({0xa260e4, 0x2081530}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x58 fp=0x2118f30 sp=0x2118efc pc=0x1d2324 Mar 25 01:30:50 volumio go-librespot[6175]: net.init.func1({0xa260e4, 0x2081530}, 0x1d1c668, {0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/hook.go:21 +0x4c fp=0x2118f60 sp=0x2118f30 pc=0x1999a8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIPAddr.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup.go:335 +0x58 fp=0x2118f9c sp=0x2118f60 pc=0x1b724c Mar 25 01:30:50 volumio go-librespot[6175]: internal/singleflight.(*Group).doCall(0xfd1668, 0x2081560, {0x1e2e3f0, 0x16}, 0x1f10aa0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x1c fp=0x2118fd4 sp=0x2118f9c pc=0x197c48 Mar 25 01:30:50 volumio go-librespot[6175]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x48 fp=0x2118fec sp=0x2118fd4 pc=0x197c00 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2118fec sp=0x2118fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by internal/singleflight.(*Group).DoChan in goroutine 14822011 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x304 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822044 gp=0x20eaa28 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c57b60 sp=0x1c57b4c pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1c57c68, 0x1c57c38, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1c57c10 sp=0x1c57b60 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net.doBlockingWithCtx[...]({0xa260e4, 0x2086cf0}, {0x1c9e760, 0x15}, 0x1ec2dc8) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:71 +0x280 fp=0x1c57c90 sp=0x1c57c10 pc=0x1cc630 Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupIP({0xa260e4, 0x2086cf0}, {0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:228 +0x98 fp=0x1c57cc0 sp=0x1c57c90 pc=0x19c334 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIP(0xfd1660, {0xa260e4, 0x2086cf0}, {0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup_unix.go:64 +0x90 fp=0x1c57efc sp=0x1c57cc0 pc=0x1b7a0c Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIP-fm({0xa260e4, 0x2086cf0}, {0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x58 fp=0x1c57f30 sp=0x1c57efc pc=0x1d2324 Mar 25 01:30:50 volumio go-librespot[6175]: net.init.func1({0xa260e4, 0x2086cf0}, 0x324c520, {0x903a4e, 0x3}, {0x1c9e760, 0x15}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/hook.go:21 +0x4c fp=0x1c57f60 sp=0x1c57f30 pc=0x1999a8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIPAddr.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup.go:335 +0x58 fp=0x1c57f9c sp=0x1c57f60 pc=0x1b724c Mar 25 01:30:50 volumio go-librespot[6175]: internal/singleflight.(*Group).doCall(0xfd1668, 0x2086d20, {0x1c9e780, 0x19}, 0x39494a0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x1c fp=0x1c57fd4 sp=0x1c57f9c pc=0x197c48 Mar 25 01:30:50 volumio go-librespot[6175]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x48 fp=0x1c57fec sp=0x1c57fd4 pc=0x197c00 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c57fec sp=0x1c57fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by internal/singleflight.(*Group).DoChan in goroutine 14822043 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x304 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 8455397 gp=0x22daea8 m=nil [chan send, 7633 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d64, 0x1d0be78, 0xf, 0x6, 0x2) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1f4ce10 sp=0x1f4cdfc pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chansend(0x1d0be40, 0x1f4cebc, 0x1, 0x5a2794) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:283 +0x3ec fp=0x1f4ce50 sp=0x1f4ce10 pc=0x330c4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chansend1(0x1d0be40, 0x1f4cebc) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:161 +0x28 fp=0x1f4ce68 sp=0x1f4ce50 pc=0x32cd4 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleMessage(0x1e8e638, 0x2948fa0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/recv.go:181 +0x53c fp=0x1f4cf1c sp=0x1f4ce68 pc=0x5a2794 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1e8e638) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:210 +0x3f4 fp=0x1f4cfe4 sp=0x1f4cf1c pc=0x5a1534 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:125 +0x28 fp=0x1f4cfec sp=0x1f4cfe4 pc=0x5a2c94 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1f4cfec sp=0x1f4cfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 8455386 Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:125 +0x98 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821844 gp=0x23a7e68 m=nil [select, 5251 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x229c674 sp=0x229c660 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x229c780, 0x229c74c, 0x0, 0x0, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x229c724 sp=0x229c674 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x2844550) Mar 25 01:30:50 volumio go-librespot[6175]: /src/player/player.go:215 +0x1f4 fp=0x229c7e4 sp=0x229c724 pc=0x5818e0 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/player/player.go:197 +0x28 fp=0x229c7ec sp=0x229c7e4 pc=0x5814c8 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x229c7ec sp=0x229c7ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 99 Mar 25 01:30:50 volumio go-librespot[6175]: /src/player/player.go:197 +0x220 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14821948 gp=0x247d568 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x20c2608 sp=0x20c25f4 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x20c2768, 0x20c26e0, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x20c26b8 sp=0x20c2608 pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).getConn(0xf812a8, 0x20814d0, {{}, 0x0, {0x914f38, 0x5}, {0x1e2e3d8, 0x16}, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1523 +0x370 fp=0x20c27b4 sp=0x20c26b8 pc=0x351440 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).roundTrip(0xf812a8, 0x1e99298) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:685 +0x978 fp=0x20c28a0 sp=0x20c27b4 pc=0x34d528 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).RoundTrip(0xf812a8, 0x1e99298) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/roundtrip.go:33 +0x2c fp=0x20c28b8 sp=0x20c28a0 pc=0x35ba84 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.send(0x1e98d18, {0xa21b28, 0xf812a8}, {0xc268e910a9075902, 0x2a0cf19d05bec, 0xfd1e68}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:259 +0x53c fp=0x20c29e4 sp=0x20c28b8 pc=0x2ed3ec Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).send(0x1c8c2c0, 0x1e98d18, {0xc268e910a9075902, 0x2a0cf19d05bec, 0xfd1e68}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:180 +0x98 fp=0x20c2a28 sp=0x20c29e4 pc=0x2eccd8 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).do(0x1c8c2c0, 0x1e98d18) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:729 +0x9a8 fp=0x20c2b38 sp=0x20c2a28 pc=0x2ef340 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Client).Do(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/client.go:587 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/login5.(*Login5).request(0x348c780, {0xa260ac, 0xfdcff0}, 0x2081440) Mar 25 01:30:50 volumio go-librespot[6175]: /src/login5/login5.go:72 +0x4b8 fp=0x20c2c5c sp=0x20c2b38 pc=0x5aed88 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/login5.(*Login5).Login(0x348c780, {0xa260ac, 0xfdcff0}, {0xa22408, 0x2081410}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/login5/login5.go:122 +0x4b8 fp=0x20c2cf0 sp=0x20c2c5c pc=0x5af580 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/session.NewSessionFromOptions.(*Login5).AccessToken.func2({0xa260ac, 0xfdcff0}, 0x0) Mar 25 01:30:50 volumio go-librespot[6175]: /src/login5/login5.go:200 +0x1e4 fp=0x20c2d8c sp=0x20c2cf0 pc=0x5b6d34 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).connect(0x1d7ebb8, {0xa260ac, 0xfdcff0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:82 +0xc8 fp=0x20c2e1c sp=0x20c2d8c pc=0x5a0790 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect(0x1d7ebb8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:288 +0x2c fp=0x20c2e54 sp=0x20c2e1c pc=0x5a1c74 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect-fm() Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x28 fp=0x20c2e64 sp=0x20c2e54 pc=0x5a35d8 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x1c fp=0x20c2e70 sp=0x20c2e64 pc=0x4ea1ec Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x20c2f14, {0xa24f50, 0x21383c0}, 0x0, {0x0, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0xcc fp=0x20c2eec sp=0x20c2e70 pc=0x4ea668 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x20c2f68, {0xa24f50, 0x21383c0}, 0x0, {0x0, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x5c fp=0x20c2f1c sp=0x20c2eec pc=0x4ea1a4 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/cenkalti/backoff/v4.Retry(...) Mar 25 01:30:50 volumio go-librespot[6175]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1d7ebb8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:237 +0x688 fp=0x20c2fe4 sp=0x20c2f1c pc=0x5a17c8 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:296 +0x28 fp=0x20c2fec sp=0x20c2fe4 pc=0x5a1df4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x20c2fec sp=0x20c2fec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect in goroutine 14821866 Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:296 +0xf8 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 11221253 gp=0x252c008 m=nil [chan send, 6502 minutes]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960d64, 0x1ff5078, 0xf, 0x6, 0x2) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x211ad48 sp=0x211ad34 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chansend(0x1ff5040, 0x211adf4, 0x1, 0x5a2ef0) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:283 +0x3ec fp=0x211ad88 sp=0x211ad48 pc=0x330c4 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.chansend1(0x1ff5040, 0x211adf4) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/chan.go:161 +0x28 fp=0x211ada0 sp=0x211ad88 pc=0x32cd4 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x1e99ef8, 0x1fcee10) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/recv.go:230 +0x1dc fp=0x211af1c sp=0x211ada0 pc=0x5a2ef0 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1e99ef8) Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:213 +0x4d0 fp=0x211afe4 sp=0x211af1c pc=0x5a1610 Mar 25 01:30:50 volumio go-librespot[6175]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:125 +0x28 fp=0x211afec sp=0x211afe4 pc=0x5a2c94 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x211afec sp=0x211afec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 11221220 Mar 25 01:30:50 volumio go-librespot[6175]: /src/dealer/dealer.go:125 +0x98 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822013 gp=0x261a5a8 m=8 mp=0x1d0c808 [syscall]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.cgocall(0x74cab0, 0x210b6fc) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/cgocall.go:167 +0x50 fp=0x210b6e4 sp=0x210b6cc pc=0xa628c Mar 25 01:30:50 volumio go-librespot[6175]: net._C2func_getaddrinfo(0x1e2e438, 0x0, 0x1f10c40, 0x1d1c680) Mar 25 01:30:50 volumio go-librespot[6175]: _cgo_gotypes.go:105 +0x44 fp=0x210b6f8 sp=0x210b6e4 pc=0x1c97c8 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo.func1(...) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 25 01:30:50 volumio go-librespot[6175]: net._C_getaddrinfo(0x1e2e438, 0x0, 0x1f10c40, 0x1d1c680) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x80 fp=0x210b718 sp=0x210b6f8 pc=0x1c9a8c Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupHostIP({0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:174 +0x1f4 fp=0x210b78c sp=0x210b718 pc=0x19bd90 Mar 25 01:30:50 volumio go-librespot[6175]: net.cgoLookupIP.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:229 +0x34 fp=0x210b7b4 sp=0x210b78c pc=0x19c3b4 Mar 25 01:30:50 volumio go-librespot[6175]: net.doBlockingWithCtx[...].func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:67 +0x54 fp=0x210b7ec sp=0x210b7b4 pc=0x1cc878 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x210b7ec sp=0x210b7ec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net.doBlockingWithCtx[...] in goroutine 14822012 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/cgo_unix.go:64 +0x204 Mar 25 01:30:50 volumio go-librespot[6175]: goroutine 14822011 gp=0x261b0e8 m=nil [select]: Mar 25 01:30:50 volumio go-librespot[6175]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1c5c86c sp=0x1c5c858 pc=0xa97c0 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.selectgo(0x1c5c9dc, 0x1c5c948, 0x0, 0x0, 0x2, 0x1) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1c5c91c sp=0x1c5c86c pc=0x85000 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).lookupIPAddr(0xfd1660, {0xa2611c, 0x2844140}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x12}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/lookup.go:343 +0x394 fp=0x1c5ca24 sp=0x1c5c91c pc=0x1b68b0 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).internetAddrList(0xfd1660, {0xa2611c, 0x2844140}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x16}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/ipsock.go:289 +0x6b0 fp=0x1c5cab8 sp=0x1c5ca24 pc=0x1b486c Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Resolver).resolveAddrList(0xfd1660, {0xa2611c, 0x2844140}, {0x903e50, 0x4}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x16}, {0x0, ...}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/dial.go:353 +0x510 fp=0x1c5cb40 sp=0x1c5cab8 pc=0x19f1a8 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Dialer).DialContext(0x1e127e0, {0xa260e4, 0x2081500}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x16}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/dial.go:560 +0x43c fp=0x1c5cc3c sp=0x1c5cb40 pc=0x1a00e4 Mar 25 01:30:50 volumio go-librespot[6175]: net.(*Dialer).DialContext-fm({0xa260e4, 0x2081500}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x16}) Mar 25 01:30:50 volumio go-librespot[6175]: :1 +0x58 fp=0x1c5cc6c sp=0x1c5cc3c pc=0x368914 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dial(0xf812a8, {0xa260e4, 0x2081500}, {0x903a4e, 0x3}, {0x1e2e3d8, 0x16}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1278 +0x158 fp=0x1c5ccac sp=0x1c5cc6c pc=0x3506d4 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dialConn(0xf812a8, {0xa260e4, 0x2081500}, {{}, 0x0, {0x914f38, 0x5}, {0x1e2e3d8, 0x16}, 0x0}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1783 +0x6a4 fp=0x1c5cf60 sp=0x1c5ccac pc=0x3530b0 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).dialConnFor(0xf812a8, 0x1c2a540) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1618 +0x80 fp=0x1c5cfc4 sp=0x1c5cf60 pc=0x351e80 Mar 25 01:30:50 volumio go-librespot[6175]: net/http.(*Transport).startDialConnForLocked.func1() Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1600 +0x3c fp=0x1c5cfec sp=0x1c5cfc4 pc=0x351d08 Mar 25 01:30:50 volumio go-librespot[6175]: runtime.goexit({}) Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c5cfec sp=0x1c5cfec pc=0xb0874 Mar 25 01:30:50 volumio go-librespot[6175]: created by net/http.(*Transport).startDialConnForLocked in goroutine 14821948 Mar 25 01:30:50 volumio go-librespot[6175]: /usr/local/go/src/net/http/transport.go:1599 +0x134 Mar 25 01:30:50 volumio go-librespot[6174]: Aborted Mar 25 01:30:53 volumio volumio[5988]: info: Initializing connection to go-librespot Websocket Mar 25 01:30:53 volumio volumio[5988]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 25 01:30:53 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Mar 25 01:30:53 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 25 01:30:53 volumio systemd[1]: go-librespot-daemon.service: Consumed 31min 21.770s CPU time. Mar 25 01:30:53 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 25 01:30:53 volumio go-librespot[25245]: go-librespot daemon starting... Mar 25 01:30:53 volumio go-librespot[25246]: time="2026-03-25T01:30:53+01:00" level=info msg="running go-librespot 0.6.2" Mar 25 01:30:53 volumio go-librespot[25246]: time="2026-03-25T01:30:53+01:00" level=debug msg="app state loaded" Mar 25 01:30:53 volumio go-librespot[25246]: time="2026-03-25T01:30:53+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 25 01:30:56 volumio volumio[5988]: info: Initializing connection to go-librespot Websocket Mar 25 01:30:56 volumio go-librespot[25246]: time="2026-03-25T01:30:56+01:00" level=debug msg="new websocket client" Mar 25 01:30:56 volumio volumio[5988]: info: Connection to go-librespot Websocket established Mar 25 01:30:59 volumio volumio[5988]: info: Getting Spotify volume Mar 25 01:30:59 volumio volumio[5988]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 25 01:30:59 volumio volumio[5988]: info: CoreCommandRouter::volumioGetState Mar 25 01:30:59 volumio volumio[5988]: SPOTIFY: RECEIVED VOLUMIO VOLUME 73 Mar 25 01:31:15 volumio go-librespot[25246]: time="2026-03-25T01:31:15+01:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Mar 25 01:31:15 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 25 01:31:15 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 25 01:31:15 volumio volumio[5988]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 01:31:15 volumio volumio[5988]: Error: socket hang up Mar 25 01:31:15 volumio volumio[5988]: at connResetException (node:internal/errors:720:14) Mar 25 01:31:15 volumio volumio[5988]: at Socket.socketOnEnd (node:_http_client:519:23) Mar 25 01:31:15 volumio volumio[5988]: at Socket.emit (node:events:526:35) Mar 25 01:31:15 volumio volumio[5988]: at endReadableNT (node:internal/streams/readable:1376:12) Mar 25 01:31:15 volumio volumio[5988]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 25 01:31:15 volumio volumio[5988]: code: 'ECONNRESET', Mar 25 01:31:15 volumio volumio[5988]: response: undefined Mar 25 01:31:15 volumio volumio[5988]: } Mar 25 01:31:15 volumio volumio[5988]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 25 01:31:16 volumio sudo[25318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-25 01:30' Mar 25 01:31:16 volumio sudo[25318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"