Mar 04 09:04:04 volumio go-librespot[1538]: time="2026-03-04T09:04:04+01:00" level=trace msg="sent dealer ping" Mar 04 09:04:34 volumio go-librespot[1538]: time="2026-03-04T09:04:34+01:00" level=error msg="did not receive last pong from dealer, 67s passed" Mar 04 09:04:39 volumio go-librespot[1538]: time="2026-03-04T09:04:39+01:00" level=error msg="failed receiving dealer message" error="failed to read: use of closed network connection" Mar 04 09:05:00 volumio go-librespot[1538]: time="2026-03-04T09:05:00+01:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.0.169:36716->34.158.1.133:80: read: connection reset by peer" Mar 04 09:05:04 volumio go-librespot[1538]: time="2026-03-04T09:05:04+01:00" level=error msg="did not receive last pong from dealer, 97s passed" Mar 04 09:05:04 volumio go-librespot[1538]: time="2026-03-04T09:05:04+01:00" level=error msg="did not receive last pong ack from accesspoint, 191s passed" Mar 04 09:05:04 volumio go-librespot[1538]: panic: runtime error: invalid memory address or nil pointer dereference Mar 04 09:05:04 volumio go-librespot[1538]: [signal SIGSEGV: segmentation violation code=0x1 addr=0xc pc=0x4f7ef0] Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 48 gp=0x29f2908 m=3 mp=0x284d008 [running]: Mar 04 09:05:04 volumio go-librespot[1538]: panic({0x841d88, 0xfa0250}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x2856f20 sp=0x2856ecc pc=0xa92ec Mar 04 09:05:04 volumio go-librespot[1538]: runtime.panicmem(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/panic.go:262 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.sigpanic() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x2856f50 sp=0x2856f20 pc=0xabca4 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x2b7e798) Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:380 +0x284 fp=0x2856fe4 sp=0x2856f54 pc=0x4f7ef0 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:277 +0x28 fp=0x2856fec sp=0x2856fe4 pc=0x4f73c4 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2856fec sp=0x2856fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 59 Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:277 +0x15c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 1 gp=0x2802128 m=nil [select, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x285cce0 sp=0x285cccc pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x285cdf0, 0x2b0fdbc, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x285cd90 sp=0x285cce0 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x2a0c660, 0x285ce90) Mar 04 09:05:04 volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:300 +0x228 fp=0x285ce38 sp=0x285cd90 pc=0x62f43c Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).withAppPlayer(0x29ae400, {0xa3da1c, 0x1005090}, 0x28114b0) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:340 +0x5dc fp=0x285ced0 sp=0x285ce38 pc=0x6bcc60 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).withCredentials(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:209 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).SpotifyToken(0x29ae400, {0xa3da1c, 0x1005090}, {0x2812520, 0x10}, {0x2b02000, 0x12c}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x285cf00 sp=0x285ced0 pc=0x6bc02c Mar 04 09:05:04 volumio go-librespot[1538]: main.main() Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:620 +0x660 fp=0x285cfa8 sp=0x285cf00 pc=0x6bf56c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.main() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x285cfec sp=0x285cfa8 pc=0x6f390 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x285cfec sp=0x285cfec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 2 gp=0x28027e8 m=nil [force gc (idle), 2 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97746c, 0xff8fa8, 0x11, 0xa, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2848fd4 sp=0x2848fc0 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goparkunlock(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:466 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.forcegchelper() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x2848fec sp=0x2848fd4 pc=0x6f7f4 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2848fec sp=0x2848fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.init.6 in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:361 +0x1c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 3 gp=0x2802b48 m=nil [GC sweep wait]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97746c, 0xff9850, 0xc, 0x9, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28497c4 sp=0x28497b0 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goparkunlock(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:466 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.bgsweep(0x282e050) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x28497e4 sp=0x28497c4 pc=0x5768c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcenable.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x28497ec sp=0x28497e4 pc=0x46c3c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28497ec sp=0x28497ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcenable in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 4 gp=0x2802c68 m=nil [GC scavenge wait]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97746c, 0xffa170, 0xd, 0xa, 0x2) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2849fb4 sp=0x2849fa0 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goparkunlock(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:466 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.(*scavengerState).park(0xffa170) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2849fc8 sp=0x2849fb4 pc=0x54a28 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.bgscavenge(0x282e050) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x2849fe4 sp=0x2849fc8 pc=0x5516c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcenable.gowrap2() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x2849fec sp=0x2849fe4 pc=0x46be8 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2849fec sp=0x2849fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcenable in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 5 gp=0x2802fc8 m=nil [GOMAXPROCS updater (idle), 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97746c, 0xff95e8, 0x12, 0xa, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284a7a4 sp=0x284a790 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goparkunlock(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:466 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.updateMaxProcsGoroutine() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x284a7ec sp=0x284a7a4 pc=0x7f174 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284a7ec sp=0x284a7ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 18 gp=0x290c008 m=nil [finalizer wait, 171 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x977314, 0x1005180, 0x10, 0xa, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2844788 sp=0x2844774 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.runFinalizers() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x28447ec sp=0x2844788 pc=0x45888 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28447ec sp=0x28447ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.createfing in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 6 gp=0x2803b08 m=nil [cleanup wait, 59 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97746c, 0xffa348, 0x2e, 0xa, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284afa4 sp=0x284af90 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goparkunlock(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:466 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.(*cleanupQueue).dequeue(0xffa2e8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x284afc4 sp=0x284afa4 pc=0x41cb0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.runCleanups() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x284afec sp=0x284afc4 pc=0x4284c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284afec sp=0x284afec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 9 gp=0x29f2d88 m=nil [IO wait, 173 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97745c, 0x74f86e10, 0x2, 0x2, 0x5) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29d4cf0 sp=0x29d4cdc pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.netpollblock(0x74f86e00, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x29d4d08 sp=0x29d4cf0 pc=0x675a0 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.runtime_pollWait(0x74f86e00, 0x72) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x29d4d1c sp=0x29d4d08 pc=0xa8864 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x29e7148, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x29d4d30 sp=0x29d4d1c pc=0x136044 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*FD).Accept(0x29e7130) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x29d4d78 sp=0x29d4d30 pc=0x13a800 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*netFD).accept(0x29e7130) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x29d4de0 sp=0x29d4d78 pc=0x1abc28 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*TCPListener).accept(0x28003c0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x29d4e34 sp=0x29d4de0 pc=0x1c3554 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*TCPListener).Accept(0x28003c0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x29d4e50 sp=0x29d4e34 pc=0x1c259c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*onceCloseListener).Accept(0x28a11e0) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x34 fp=0x29d4e68 sp=0x29d4e50 pc=0x367f9c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Server).Serve(0x28ca218, {0xa3d218, 0x28003c0}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x29d4f00 sp=0x29d4e68 pc=0x341154 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.Serve(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2971 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*ConcreteApiServer).serve(0x282a3c0) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x29d4fe4 sp=0x29d4f00 pc=0x6b17bc Mar 04 09:05:04 volumio go-librespot[1538]: main.NewApiServer.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x29d4fec sp=0x29d4fe4 pc=0x6b04f4 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29d4fec sp=0x29d4fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by main.NewApiServer in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:332 +0x310 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 19 gp=0x29f30e8 m=nil [GC worker (idle), 191 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x977320, 0x2ab2000, 0x1c, 0xa, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2d1af88 sp=0x2d1af74 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkWorker(0x2aa0380) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2d1afe4 sp=0x2d1af88 pc=0x49f34 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2d1afec sp=0x2d1afe4 pc=0x49e14 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2d1afec sp=0x2d1afec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 13 gp=0x29f3328 m=nil [IO wait, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97745c, 0x74f86c10, 0x2, 0x2, 0x5) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b0b908 sp=0x2b0b8f4 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.netpollblock(0x74f86c00, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2b0b920 sp=0x2b0b908 pc=0x675a0 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.runtime_pollWait(0x74f86c00, 0x72) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2b0b934 sp=0x2b0b920 pc=0xa8864 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x29e7378, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2b0b948 sp=0x2b0b934 pc=0x136044 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*FD).Read(0x29e7360, {0x2a3e000, 0x1000, 0x1000}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2b0b990 sp=0x2b0b948 pc=0x1371c4 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*netFD).Read(0x29e7360, {0x2a3e000, 0x1000, 0x1000}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2b0b9bc sp=0x2b0b990 pc=0x1a9e78 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*conn).Read(0x2833a70, {0x2a3e000, 0x1000, 0x1000}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2b0b9e8 sp=0x2b0b9bc pc=0x1b967c Mar 04 09:05:04 volumio go-librespot[1538]: io.(*multiReader).Read(0x29101d0, {0x2a3e000, 0x1000, 0x1000}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2b0ba14 sp=0x2b0b9e8 pc=0xefb88 Mar 04 09:05:04 volumio go-librespot[1538]: bufio.(*Reader).fill(0x28bc900) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2b0ba38 sp=0x2b0ba14 pc=0x2b6c1c Mar 04 09:05:04 volumio go-librespot[1538]: bufio.(*Reader).ReadByte(0x28bc900) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2b0ba44 sp=0x2b0ba38 pc=0x2b7498 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.readFrameHeader(0x28bc900, {0x2aa2038, 0x8, 0x8}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x2b0ba84 sp=0x2b0ba44 pc=0x372a08 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.(*Conn).readFrameHeader(0x2aa2008, {0xa3da00, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x2b0bb08 sp=0x2b0ba84 pc=0x375bd4 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.(*Conn).readLoop(0x2aa2008, {0xa3da00, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x2b0bbcc sp=0x2b0bb08 pc=0x375390 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.(*Conn).reader(0x2aa2008, {0xa3da00, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x2b0bc50 sp=0x2b0bbcc pc=0x376798 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.(*Conn).Reader(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.(*Conn).Read(0x2aa2008, {0xa3da00, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x2b0bc78 sp=0x2b0bc50 pc=0x374944 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*ConcreteApiServer).serve.func17({0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:636 +0x3b4 fp=0x2b0bcfc sp=0x2b0bc78 pc=0x6b2040 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.HandlerFunc.ServeHTTP(0x28a43a0, {0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2b0bd0c sp=0x2b0bcfc pc=0x33d7d8 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*ServeMux).ServeHTTP(0x28b0300, {0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x2b0bd4c sp=0x2b0bd0c pc=0x33f6c8 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x2b0bd74 sp=0x2b0bd4c pc=0x6b19b8 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.HandlerFunc.ServeHTTP(0x28a2420, {0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2b0bd84 sp=0x2b0bd74 pc=0x33d7d8 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.serverHandler.ServeHTTP({0x28ca218}, {0xa3d2d8, 0x28ca428}, 0x28ca2c8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x2b0bda0 sp=0x2b0bd84 pc=0x35cb44 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*conn).serve(0x282a4e0, {0xa3da38, 0x28a6528}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x2b0bfdc sp=0x2b0bda0 pc=0x33b894 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Server).Serve.gowrap3() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x2b0bfec sp=0x2b0bfdc pc=0x3415cc Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b0bfec sp=0x2b0bfec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by net/http.(*Server).Serve in goroutine 9 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3493 +0x42c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 20 gp=0x2a2a5a8 m=nil [GC worker (idle), 158 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x977320, 0x2ab2200, 0x1c, 0xa, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2aeaf88 sp=0x2aeaf74 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkWorker(0x2aa0380) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2aeafe4 sp=0x2aeaf88 pc=0x49f34 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2aeafec sp=0x2aeafe4 pc=0x49e14 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2aeafec sp=0x2aeafec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 52 gp=0x29f3448 m=nil [chan receive, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9772f4, 0x289f738, 0xe, 0x7, 0x2) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b52778 sp=0x2b52764 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv(0x289f700, 0x0, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2b527c0 sp=0x2b52778 pc=0x3414c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv1(0x289f700, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x2b527d4 sp=0x2b527c0 pc=0x33bcc Mar 04 09:05:04 volumio go-librespot[1538]: github.com/godbus/dbus/v5.newConn.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:303 +0x40 fp=0x2b527ec sp=0x2b527d4 pc=0x4aa8ec Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b527ec sp=0x2b527ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/godbus/dbus/v5.newConn in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:302 +0x52c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 21 gp=0x290cea8 m=nil [GC worker (idle)]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x977320, 0x2ab2400, 0x1c, 0xa, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2ab8f88 sp=0x2ab8f74 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkWorker(0x2aa0380) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2ab8fe4 sp=0x2ab8f88 pc=0x49f34 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2ab8fec sp=0x2ab8fe4 pc=0x49e14 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Mar 04 09:05:04 volumio volumio[1166]: info: Connection to go-librespot Websocket closed Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2ab8fec sp=0x2ab8fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 22 gp=0x290cfc8 m=nil [GC worker (idle), 191 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x977320, 0x2ab2600, 0x1c, 0xa, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2aebf88 sp=0x2aebf74 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkWorker(0x2aa0380) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2aebfe4 sp=0x2aebf88 pc=0x49f34 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2aebfec sp=0x2aebfe4 pc=0x49e14 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2aebfec sp=0x2aebfec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 53 gp=0x290d208 m=nil [IO wait, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97745c, 0x74f86610, 0x2, 0x2, 0x5) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bdfcbc sp=0x2bdfca8 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.netpollblock(0x74f86600, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2bdfcd4 sp=0x2bdfcbc pc=0x675a0 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.runtime_pollWait(0x74f86600, 0x72) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2bdfce8 sp=0x2bdfcd4 pc=0xa8864 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x2b75148, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2bdfcfc sp=0x2bdfce8 pc=0x136044 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*FD).ReadMsg(0x2b75130, {0x2bbc000, 0x10, 0x10}, {0x28d8018, 0x1000, 0x1000}, 0x40000000) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:295 +0x2c0 fp=0x2bdfd6c sp=0x2bdfcfc pc=0x1381bc Mar 04 09:05:04 volumio go-librespot[1538]: net.(*netFD).readMsg(0x2b75130, {0x2bbc000, 0x10, 0x10}, {0x28d8018, 0x1000, 0x1000}, 0x40000000) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:91 +0x58 fp=0x2bdfdc8 sp=0x2bdfd6c pc=0x1aa2c8 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*UnixConn).readMsg(0x2b70b38, {0x2bbc000, 0x10, 0x10}, {0x28d8018, 0x1000, 0x1000}) Mar 04 09:05:04 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/unixsock_posix.go:115 +0x58 fp=0x2bdfe28 sp=0x2bdfdc8 pc=0x1c9d80 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*UnixConn).ReadMsgUnix(0x2b70b38, {0x2bbc000, 0x10, 0x10}, {0x28d8018, 0x1000, 0x1000}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/unixsock.go:143 +0x58 fp=0x2bdfe78 sp=0x2bdfe28 pc=0x1c820c Mar 04 09:05:04 volumio go-librespot[1538]: github.com/godbus/dbus/v5.(*oobReader).Read(0x28d8008, {0x2bbc000, 0x10, 0x10}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:41 +0x50 fp=0x2bdfec8 sp=0x2bdfe78 pc=0x4c2af0 Mar 04 09:05:04 volumio go-librespot[1538]: io.ReadAtLeast({0xa39d58, 0x28d8008}, {0x2bbc000, 0x10, 0x10}, 0x10) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2bdfef4 sp=0x2bdfec8 pc=0xee954 Mar 04 09:05:04 volumio go-librespot[1538]: io.ReadFull(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/io/io.go:354 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/godbus/dbus/v5.(*unixTransport).ReadMessage(0x2b62f10) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:124 +0x224 fp=0x2bdffa0 sp=0x2bdfef4 pc=0x4c32c4 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/godbus/dbus/v5.(*Conn).inWorker(0x2942300) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:390 +0x44 fp=0x2bdffe4 sp=0x2bdffa0 pc=0x4aaef4 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/godbus/dbus/v5.(*Conn).Auth.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x28 fp=0x2bdffec sp=0x2bdffe4 pc=0x4a8318 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bdffec sp=0x2bdffec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/godbus/dbus/v5.(*Conn).Auth in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x77c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 686 gp=0x2a2a908 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bdbb60 sp=0x2bdbb4c pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2bdbc68, 0x2bdbc38, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2bdbc10 sp=0x2bdbb60 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: net.doBlockingWithCtx[...]({0xa3da54, 0x2becc60}, {0x29f7060, 0x17}, 0x2b64a20) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:71 +0x280 fp=0x2bdbc90 sp=0x2bdbc10 pc=0x1cd880 Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupIP({0xa3da54, 0x2becc60}, {0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:228 +0x98 fp=0x2bdbcc0 sp=0x2bdbc90 pc=0x19d584 Mar 04 09:05:04 volumio systemd[1]: go-librespot-daemon.service: Consumed 8.368s CPU time. Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIP(0xff9700, {0xa3da54, 0x2becc60}, {0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup_unix.go:64 +0x90 fp=0x2bdbefc sp=0x2bdbcc0 pc=0x1b8c5c Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIP-fm({0xa3da54, 0x2becc60}, {0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x58 fp=0x2bdbf30 sp=0x2bdbefc pc=0x1d3574 Mar 04 09:05:04 volumio go-librespot[1538]: net.init.func1({0xa3da54, 0x2becc60}, 0x2a4e9e0, {0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/hook.go:21 +0x4c fp=0x2bdbf60 sp=0x2bdbf30 pc=0x19abf8 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIPAddr.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup.go:335 +0x58 fp=0x2bdbf9c sp=0x2bdbf60 pc=0x1b849c Mar 04 09:05:04 volumio go-librespot[1538]: internal/singleflight.(*Group).doCall(0xff9708, 0x2becc90, {0x29f7080, 0x1b}, 0x2bb1440) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x1c fp=0x2bdbfd4 sp=0x2bdbf9c pc=0x198e98 Mar 04 09:05:04 volumio go-librespot[1538]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x48 fp=0x2bdbfec sp=0x2bdbfd4 pc=0x198e50 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bdbfec sp=0x2bdbfec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by internal/singleflight.(*Group).DoChan in goroutine 685 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x304 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 58 gp=0x29f2128 m=nil [select, 173 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29d9e74 sp=0x29d9e60 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x29d9f80, 0x29d9f4c, 0x0, 0x0, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x29d9f24 sp=0x29d9e74 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x2cbde50) Mar 04 09:05:04 volumio go-librespot[1538]: /src/player/player.go:215 +0x1f4 fp=0x29d9fe4 sp=0x29d9f24 pc=0x582954 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/player/player.go:197 +0x28 fp=0x29d9fec sp=0x29d9fe4 pc=0x58253c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29d9fec sp=0x29d9fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/player/player.go:197 +0x220 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 59 gp=0x29f2248 m=nil [select, 2 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a43930 sp=0x2a4391c pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2a43f70, 0x2a43b20, 0x0, 0x0, 0xa, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2a439e0 sp=0x2a43930 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*AppPlayer).Run(0x2c182d0, {0xa3da1c, 0x1005090}, 0x289e3c0, 0x289e400) Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/player.go:661 +0x368 fp=0x2a43fd4 sp=0x2a439e0 pc=0x6c5950 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).withAppPlayer.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:274 +0x48 fp=0x2a43fec sp=0x2a43fd4 pc=0x6bd9f0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a43fec sp=0x2a43fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by main.(*App).withAppPlayer in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:274 +0x46c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 60 gp=0x29f2368 m=nil [chan receive, 173 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9772f4, 0x287a1f8, 0xe, 0x7, 0x2) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2847f3c sp=0x2847f28 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv(0x287a1c0, 0x2847fd0, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2847f84 sp=0x2847f3c pc=0x3414c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv2(0x287a1c0, 0x2847fd0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x2847f98 sp=0x2847f84 pc=0x33bf0 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).withAppPlayer.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:284 +0x68 fp=0x2847fec sp=0x2847f98 pc=0x6bd918 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2847fec sp=0x2847fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by main.(*App).withAppPlayer in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:281 +0x4f8 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 61 gp=0x29f2488 m=nil [chan receive, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9772f4, 0x287a1b8, 0xe, 0x7, 0x2) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b53740 sp=0x2b5372c pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv(0x287a180, 0x2b537e0, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2b53788 sp=0x2b53740 pc=0x3414c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.chanrecv2(0x287a180, 0x2b537e0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x2b5379c sp=0x2b53788 pc=0x33bf0 Mar 04 09:05:04 volumio go-librespot[1538]: main.(*App).withAppPlayer.func2() Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:300 +0x6c fp=0x2b537ec sp=0x2b5379c pc=0x6bd47c Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b537ec sp=0x2b537ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by main.(*App).withAppPlayer in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/cmd/daemon/main.go:297 +0x598 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 62 gp=0x29f25a8 m=nil [IO wait, 198 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x97745c, 0x74f86810, 0x2, 0x2, 0x5) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b575ac sp=0x2b57598 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.netpollblock(0x74f86800, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2b575c4 sp=0x2b575ac pc=0x675a0 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.runtime_pollWait(0x74f86800, 0x72) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2b575d8 sp=0x2b575c4 pc=0xa8864 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x2b750f8, 0x72, 0x0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2b575ec sp=0x2b575d8 pc=0x136044 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 04 09:05:04 volumio go-librespot[1538]: internal/poll.(*FD).Accept(0x2b750e0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x2b57634 sp=0x2b575ec pc=0x13a800 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*netFD).accept(0x2b750e0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x2b5769c sp=0x2b57634 pc=0x1abc28 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*TCPListener).accept(0x2b73290) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2b576f0 sp=0x2b5769c pc=0x1c3554 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*TCPListener).Accept(0x2b73290) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x2b5770c sp=0x2b576f0 pc=0x1c259c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*onceCloseListener).Accept(0x2c50c80) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x34 fp=0x2b57724 sp=0x2b5770c pc=0x367f9c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Server).Serve(0x2b7e0b8, {0xa3d218, 0x2b73290}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x2b577bc sp=0x2b57724 pc=0x341154 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.Serve(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2971 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Mar 04 09:05:04 volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:297 +0x8c fp=0x2b577ec sp=0x2b577bc pc=0x62f538 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b577ec sp=0x2b577ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Mar 04 09:05:04 volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:297 +0x160 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 100 gp=0x29f27e8 m=nil [select, 191 minutes]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2ab5c80 sp=0x2ab5c6c pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2ab5e18, 0x2ab5d60, 0x0, 0x0, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2ab5d30 sp=0x2ab5c80 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).recvLoop(0x2c50ba0) Mar 04 09:05:04 volumio go-librespot[1538]: /src/audio/provider.go:63 +0x118 fp=0x2ab5fe4 sp=0x2ab5d30 pc=0x4ff6b0 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/audio/provider.go:53 +0x28 fp=0x2ab5fec sp=0x2ab5fe4 pc=0x500490 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2ab5fec sp=0x2ab5fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1 in goroutine 59 Mar 04 09:05:04 volumio go-librespot[1538]: /src/audio/provider.go:53 +0x60 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 82 gp=0x2803c28 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2857e84 sp=0x2857e70 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2857fd4, 0x2857f5c, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2857f34 sp=0x2857e84 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x2b7e008) Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:138 +0x8c fp=0x2857fe4 sp=0x2857f34 pc=0x5a1d90 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:129 +0x28 fp=0x2857fec sp=0x2857fe4 pc=0x5a3cd4 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2857fec sp=0x2857fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 59 Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:129 +0x15c Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 518 gp=0x2a2b448 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bdc868 sp=0x2bdc854 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2bdc9d8, 0x2bdc944, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2bdc918 sp=0x2bdc868 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIPAddr(0xff9700, {0xa3da8c, 0x2b75040}, {0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup.go:343 +0x394 fp=0x2bdca20 sp=0x2bdc918 pc=0x1b7b00 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).internetAddrList(0xff9700, {0xa3da8c, 0x2b75040}, {0x919486, 0x3}, {0x282c888, 0x18}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/ipsock.go:289 +0x6b0 fp=0x2bdcab4 sp=0x2bdca20 pc=0x1b5abc Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).resolveAddrList(0xff9700, {0xa3da8c, 0x2b75040}, {0x9198a7, 0x4}, {0x919486, 0x3}, {0x282c888, 0x18}, {0x0, ...}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/dial.go:353 +0x510 fp=0x2bdcb3c sp=0x2bdcab4 pc=0x1a03f8 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Dialer).DialContext(0x2bdcc68, {0xa3da8c, 0x2b75040}, {0x919486, 0x3}, {0x282c888, 0x18}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/dial.go:560 +0x43c fp=0x2bdcc38 sp=0x2bdcb3c pc=0x1a1334 Mar 04 09:05:04 volumio go-librespot[1538]: golang.org/x/net/proxy.direct.DialContext(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.48.0/proxy/direct.go:30 Mar 04 09:05:04 volumio go-librespot[1538]: golang.org/x/net/proxy.(*direct).DialContext(0x1005090, {0xa3da8c, 0x2b75040}, {0x919486, 0x3}, {0x282c888, 0x18}) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x74 fp=0x2bdcccc sp=0x2bdcc38 pc=0x4f2fcc Mar 04 09:05:04 volumio go-librespot[1538]: golang.org/x/net/proxy.Dial({0xa3da8c, 0x2b75040}, {0x919486, 0x3}, {0x282c888, 0x18}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.48.0/proxy/dial.go:28 +0xac fp=0x2bdcd08 sp=0x2bdcccc pc=0x4f0e90 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0x2b7e798, {0xa3da1c, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:95 +0x2a8 fp=0x2bdcd80 sp=0x2bdcd08 pc=0x4f5950 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0x2b7e798, {0xa3da1c, 0x1005090}, 0x2bec810) Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:205 +0xd4 fp=0x2bdcde4 sp=0x2bdcd80 pc=0x4f6a58 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0x2b7e798) Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:394 +0xcc fp=0x2bdce0c sp=0x2bdcde4 pc=0x4f8018 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x28 fp=0x2bdce1c sp=0x2bdce0c pc=0x4fc270 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x1c fp=0x2bdce28 sp=0x2bdce1c pc=0x4eb1c8 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x2bdcecc, {0xa3c8c0, 0x282b6e0}, 0x0, {0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0xcc fp=0x2bdcea4 sp=0x2bdce28 pc=0x4eb644 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x2bdcf5c, {0xa3c8c0, 0x282b6e0}, 0x0, {0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x5c fp=0x2bdced4 sp=0x2bdcea4 pc=0x4eb180 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.Retry(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x2b7e798) Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:335 +0x434 fp=0x2bdcfe4 sp=0x2bdced4 pc=0x4f7878 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:403 +0x28 fp=0x2bdcfec sp=0x2bdcfe4 pc=0x4f81cc Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bdcfec sp=0x2bdcfec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 142 Mar 04 09:05:04 volumio go-librespot[1538]: /src/ap/ap.go:403 +0x120 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 684 gp=0x2a2b328 m=7 mp=0x2a94008 [syscall]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.cgocall(0x75ea90, 0x2aec6fc) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/cgocall.go:167 +0x50 fp=0x2aec6e4 sp=0x2aec6cc pc=0xa628c Mar 04 09:05:04 volumio go-librespot[1538]: net._C2func_getaddrinfo(0x282c5e8, 0x0, 0x2bb1300, 0x2a4e940) Mar 04 09:05:04 volumio go-librespot[1538]: _cgo_gotypes.go:105 +0x44 fp=0x2aec6f8 sp=0x2aec6e4 pc=0x1caa18 Mar 04 09:05:04 volumio go-librespot[1538]: net._C_getaddrinfo.func1(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 04 09:05:04 volumio go-librespot[1538]: net._C_getaddrinfo(0x282c5e8, 0x0, 0x2bb1300, 0x2a4e940) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x80 fp=0x2aec718 sp=0x2aec6f8 pc=0x1cacdc Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupHostIP({0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:174 +0x1f4 fp=0x2aec78c sp=0x2aec718 pc=0x19cfe0 Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupIP.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:229 +0x34 fp=0x2aec7b4 sp=0x2aec78c pc=0x19d604 Mar 04 09:05:04 volumio go-librespot[1538]: net.doBlockingWithCtx[...].func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:67 +0x54 fp=0x2aec7ec sp=0x2aec7b4 pc=0x1cdac8 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2aec7ec sp=0x2aec7ec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by net.doBlockingWithCtx[...] in goroutine 683 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:64 +0x204 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 683 gp=0x2a2bb08 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bd8b60 sp=0x2bd8b4c pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2bd8c68, 0x2bd8c38, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2bd8c10 sp=0x2bd8b60 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: net.doBlockingWithCtx[...]({0xa3da54, 0x2bec870}, {0x282c888, 0x13}, 0x2b64948) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:71 +0x280 fp=0x2bd8c90 sp=0x2bd8c10 pc=0x1cd880 Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupIP({0xa3da54, 0x2bec870}, {0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:228 +0x98 fp=0x2bd8cc0 sp=0x2bd8c90 pc=0x19d584 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIP(0xff9700, {0xa3da54, 0x2bec870}, {0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup_unix.go:64 +0x90 fp=0x2bd8efc sp=0x2bd8cc0 pc=0x1b8c5c Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIP-fm({0xa3da54, 0x2bec870}, {0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x58 fp=0x2bd8f30 sp=0x2bd8efc pc=0x1d3574 Mar 04 09:05:04 volumio go-librespot[1538]: net.init.func1({0xa3da54, 0x2bec870}, 0x2a4e928, {0x919486, 0x3}, {0x282c888, 0x13}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/hook.go:21 +0x4c fp=0x2bd8f60 sp=0x2bd8f30 pc=0x19abf8 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIPAddr.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup.go:335 +0x58 fp=0x2bd8f9c sp=0x2bd8f60 pc=0x1b849c Mar 04 09:05:04 volumio go-librespot[1538]: internal/singleflight.(*Group).doCall(0xff9708, 0x2bec8a0, {0x282c5a0, 0x17}, 0x2bb12e0) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x1c fp=0x2bd8fd4 sp=0x2bd8f9c pc=0x198e98 Mar 04 09:05:04 volumio go-librespot[1538]: internal/singleflight.(*Group).DoChan.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x48 fp=0x2bd8fec sp=0x2bd8fd4 pc=0x198e50 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bd8fec sp=0x2bd8fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by internal/singleflight.(*Group).DoChan in goroutine 518 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x304 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 607 gp=0x2a2be68 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a456b4 sp=0x2a456a0 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x2a45814, 0x2a4578c, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2a45764 sp=0x2a456b4 pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).getConn(0xfa9328, 0x2becc00, {{}, 0x0, {0x2a7f680, 0x5}, {0x29f7060, 0x1b}, 0x1}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1523 +0x370 fp=0x2a45860 sp=0x2a45764 pc=0x351ccc Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).roundTrip(0xfa9328, 0x2b7f3f8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:685 +0x978 fp=0x2a4594c sp=0x2a45860 pc=0x34ddb4 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).RoundTrip(0xfa9328, 0x2b7f3f8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/roundtrip.go:33 +0x2c fp=0x2a45964 sp=0x2a4594c pc=0x35c310 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.send(0x2b7f3f8, {0xa39338, 0xfa9328}, {0x0, 0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/client.go:259 +0x53c fp=0x2a45a90 sp=0x2a45964 pc=0x2edc78 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Client).send(0x2bb1360, 0x2b7f3f8, {0x0, 0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/client.go:180 +0x98 fp=0x2a45ad4 sp=0x2a45a90 pc=0x2ed564 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Client).do(0x2bb1360, 0x2b7f3f8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/client.go:729 +0x9a8 fp=0x2a45be4 sp=0x2a45ad4 pc=0x2efbcc Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Client).Do(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/client.go:587 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.handshakeRequest({0xa3da8c, 0x2b75b80}, {0x2a7f4a0, 0x1d4}, 0x2bec8d0, 0x0, {0x282c600, 0x18}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/dial.go:223 +0x9e4 fp=0x2a45cbc sp=0x2a45be4 pc=0x3717e8 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.dial({0xa3da1c, 0x1005090}, {0x2a7f4a0, 0x1d4}, 0x2a45dd8, {0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/dial.go:143 +0x24c fp=0x2a45d88 sp=0x2a45cbc pc=0x37046c Mar 04 09:05:04 volumio go-librespot[1538]: github.com/coder/websocket.Dial(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/dial.go:121 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).connect(0x2b7e008, {0xa3da1c, 0x1005090}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:87 +0x31c fp=0x2a45e1c sp=0x2a45d88 pc=0x5a1a98 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect(0x2b7e008) Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:288 +0x2c fp=0x2a45e54 sp=0x2a45e1c pc=0x5a2d08 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect-fm() Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x28 fp=0x2a45e64 sp=0x2a45e54 pc=0x5a466c Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x1c fp=0x2a45e70 sp=0x2a45e64 pc=0x4eb1c8 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x2a45f14, {0xa3c8c0, 0x282b440}, 0x0, {0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0xcc fp=0x2a45eec sp=0x2a45e70 pc=0x4eb644 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x2859f68, {0xa3c8c0, 0x282b440}, 0x0, {0x0, 0x0}) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x5c fp=0x2a45f1c sp=0x2a45eec pc=0x4eb180 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/cenkalti/backoff/v4.Retry(...) Mar 04 09:05:04 volumio go-librespot[1538]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x2b7e008) Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:237 +0x688 fp=0x2a45fe4 sp=0x2a45f1c pc=0x5a285c Mar 04 09:05:04 volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect.gowrap1() Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:296 +0x28 fp=0x2a45fec sp=0x2a45fe4 pc=0x5a2e88 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a45fec sp=0x2a45fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect in goroutine 537 Mar 04 09:05:04 volumio go-librespot[1538]: /src/dealer/dealer.go:296 +0xf8 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 685 gp=0x2ad4c68 m=nil [select]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29d686c sp=0x29d6858 pc=0xa97c0 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.selectgo(0x29d69dc, 0x29d6948, 0x0, 0x0, 0x2, 0x1) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x29d691c sp=0x29d686c pc=0x85000 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).lookupIPAddr(0xff9700, {0xa3da8c, 0x2b75cc0}, {0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/lookup.go:343 +0x394 fp=0x29d6a24 sp=0x29d691c pc=0x1b7b00 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).internetAddrList(0xff9700, {0xa3da8c, 0x2b75cc0}, {0x919486, 0x3}, {0x29f7060, 0x1b}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/ipsock.go:289 +0x6b0 fp=0x29d6ab8 sp=0x29d6a24 pc=0x1b5abc Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Resolver).resolveAddrList(0xff9700, {0xa3da8c, 0x2b75cc0}, {0x9198a7, 0x4}, {0x919486, 0x3}, {0x29f7060, 0x1b}, {0x0, ...}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/dial.go:353 +0x510 fp=0x29d6b40 sp=0x29d6ab8 pc=0x1a03f8 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Dialer).DialContext(0x2a30690, {0xa3da54, 0x2becc30}, {0x919486, 0x3}, {0x29f7060, 0x1b}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/dial.go:560 +0x43c fp=0x29d6c3c sp=0x29d6b40 pc=0x1a1334 Mar 04 09:05:04 volumio go-librespot[1538]: net.(*Dialer).DialContext-fm({0xa3da54, 0x2becc30}, {0x919486, 0x3}, {0x29f7060, 0x1b}) Mar 04 09:05:04 volumio go-librespot[1538]: :1 +0x58 fp=0x29d6c6c sp=0x29d6c3c pc=0x3691a0 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).dial(0xfa9328, {0xa3da54, 0x2becc30}, {0x919486, 0x3}, {0x29f7060, 0x1b}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1278 +0x158 fp=0x29d6cac sp=0x29d6c6c pc=0x350f60 Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).dialConn(0xfa9328, {0xa3da54, 0x2becc30}, {{}, 0x0, {0x2a7f680, 0x5}, {0x29f7060, 0x1b}, 0x1}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1783 +0x6a4 fp=0x29d6f60 sp=0x29d6cac pc=0x35393c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).dialConnFor(0xfa9328, 0x282b740) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1618 +0x80 fp=0x29d6fc4 sp=0x29d6f60 pc=0x35270c Mar 04 09:05:04 volumio go-librespot[1538]: net/http.(*Transport).startDialConnForLocked.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1600 +0x3c fp=0x29d6fec sp=0x29d6fc4 pc=0x352594 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29d6fec sp=0x29d6fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by net/http.(*Transport).startDialConnForLocked in goroutine 607 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/http/transport.go:1599 +0x134 Mar 04 09:05:04 volumio go-librespot[1538]: goroutine 687 gp=0x2ad5208 m=6 mp=0x2888008 [syscall]: Mar 04 09:05:04 volumio go-librespot[1538]: runtime.cgocall(0x75ea90, 0x2d16efc) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/cgocall.go:167 +0x50 fp=0x2d16ee4 sp=0x2d16ecc pc=0xa628c Mar 04 09:05:04 volumio go-librespot[1538]: net._C2func_getaddrinfo(0x282c648, 0x0, 0x2bb1460, 0x2a4e9f8) Mar 04 09:05:04 volumio go-librespot[1538]: _cgo_gotypes.go:105 +0x44 fp=0x2d16ef8 sp=0x2d16ee4 pc=0x1caa18 Mar 04 09:05:04 volumio go-librespot[1538]: net._C_getaddrinfo.func1(...) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Mar 04 09:05:04 volumio go-librespot[1538]: net._C_getaddrinfo(0x282c648, 0x0, 0x2bb1460, 0x2a4e9f8) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x80 fp=0x2d16f18 sp=0x2d16ef8 pc=0x1cacdc Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupHostIP({0x919486, 0x3}, {0x29f7060, 0x17}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:174 +0x1f4 fp=0x2d16f8c sp=0x2d16f18 pc=0x19cfe0 Mar 04 09:05:04 volumio go-librespot[1538]: net.cgoLookupIP.func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:229 +0x34 fp=0x2d16fb4 sp=0x2d16f8c pc=0x19d604 Mar 04 09:05:04 volumio go-librespot[1538]: net.doBlockingWithCtx[...].func1() Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:67 +0x54 fp=0x2d16fec sp=0x2d16fb4 pc=0x1cdac8 Mar 04 09:05:04 volumio go-librespot[1538]: runtime.goexit({}) Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2d16fec sp=0x2d16fec pc=0xb0874 Mar 04 09:05:04 volumio go-librespot[1538]: created by net.doBlockingWithCtx[...] in goroutine 686 Mar 04 09:05:04 volumio go-librespot[1538]: /usr/local/go/src/net/cgo_unix.go:64 +0x204 Mar 04 09:05:04 volumio go-librespot[1534]: Aborted Mar 04 09:05:07 volumio volumio[1166]: info: Initializing connection to go-librespot Websocket Mar 04 09:05:07 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Mar 04 09:05:07 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 04 09:05:07 volumio systemd[1]: go-librespot-daemon.service: Consumed 8.368s CPU time. Mar 04 09:05:07 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 04 09:05:07 volumio go-librespot[22225]: go-librespot daemon starting... Mar 04 09:05:07 volumio go-librespot[22226]: time="2026-03-04T09:05:07+01:00" level=info msg="running go-librespot 0.7.1" Mar 04 09:05:07 volumio go-librespot[22226]: time="2026-03-04T09:05:07+01:00" level=debug msg="app state loaded" Mar 04 09:05:07 volumio go-librespot[22226]: time="2026-03-04T09:05:07+01:00" level=info msg="api server listening on 127.0.0.1:9879" Mar 04 09:05:09 volumio go-librespot[22226]: time="2026-03-04T09:05:09+01:00" level=debug msg="new websocket client" Mar 04 09:05:09 volumio volumio[1166]: info: Connection to go-librespot Websocket established Mar 04 09:05:12 volumio volumio[1166]: info: Getting Spotify volume Mar 04 09:05:12 volumio volumio[1166]: 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 04 09:05:12 volumio volumio[1166]: info: CoreCommandRouter::volumioGetState Mar 04 09:05:12 volumio volumio[1166]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Mar 04 09:05:23 volumio go-librespot[22226]: time="2026-03-04T09:05:23+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Mar 04 09:05:23 volumio go-librespot[22226]: time="2026-03-04T09:05:23+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 04 09:05:23 volumio go-librespot[22226]: time="2026-03-04T09:05:23+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 04 09:05:23 volumio go-librespot[22226]: time="2026-03-04T09:05:23+01:00" level=info msg="zeroconf server listening on port 38839" Mar 04 09:05:23 volumio go-librespot[22226]: time="2026-03-04T09:05:23+01:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Mar 04 09:05:53 volumio go-librespot[22226]: time="2026-03-04T09:05:53+01:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" Mar 04 09:05:53 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 04 09:05:53 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 04 09:05:53 volumio volumio[1166]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 09:05:53 volumio volumio[1166]: Error: socket hang up Mar 04 09:05:53 volumio volumio[1166]: at connResetException (node:internal/errors:720:14) Mar 04 09:05:53 volumio volumio[1166]: at Socket.socketOnEnd (node:_http_client:519:23) Mar 04 09:05:53 volumio volumio[1166]: at Socket.emit (node:events:526:35) Mar 04 09:05:53 volumio volumio[1166]: at endReadableNT (node:internal/streams/readable:1376:12) Mar 04 09:05:53 volumio volumio[1166]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 04 09:05:53 volumio volumio[1166]: code: 'ECONNRESET', Mar 04 09:05:53 volumio volumio[1166]: response: undefined Mar 04 09:05:53 volumio volumio[1166]: } Mar 04 09:05:53 volumio volumio[1166]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 09:05:53 volumio sudo[22329]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-04 09:04' Mar 04 09:05:53 volumio sudo[22329]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"