Apr 15 18:18:16 125volumio go-librespot[1538]: time="2026-04-15T18:18:16+09:00" level=debug msg="obtained new client token: AACionmN5aHGWL+Ga9Y09Gq0dAfveucQSpAnQA41IxKOGmo+e7ue9AHWmMvsB9LIbY0aCxBeqbeJud9FOuV5v/1oyX067DrH1FrRWp4PG6ZQ2tMNhYfG9caQ5tQh6cfBGO4Pie67jqGsRQeuTofbrwRn6x3Muo3GwpZbfcdLXL4ybs/R1WLyxGFHAsCaOPWzRjjnMYenA7e2dSv/TW033EwViGIeYPMNj+l3nuiDGJAYCtP5roLZ2Z63hyLj" Apr 15 18:18:16 125volumio go-librespot[1538]: time="2026-04-15T18:18:16+09:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="completed keyexchange" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="completed challenge" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=info msg="authenticated AP" username="d9*********************gh" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=info msg="authenticated Login5" username="d9*********************gh" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=info msg="accepted zeroconf from RYU-PC" username="d9*********************gh" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="dealer connection opened" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=trace msg="starting accesspoint recv loop" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=trace msg="starting dealer recv loop" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=trace msg="received accesspoint ping" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 15 18:18:17 125volumio go-librespot[1538]: time="2026-04-15T18:18:17+09:00" level=debug msg="received connection id: MjNlNjM1ODMtY2E3...MkYxQkM3QzhBMQ==" Apr 15 18:18:18 125volumio go-librespot[1538]: time="2026-04-15T18:18:18+09:00" level=debug msg="put connect state because NEW_DEVICE" Apr 15 18:18:18 125volumio go-librespot[1538]: time="2026-04-15T18:18:18+09:00" level=trace msg="received accesspoint pong ack" Apr 15 18:18:18 125volumio go-librespot[1538]: time="2026-04-15T18:18:18+09:00" level=debug msg="handling transfer player command from 5b7a5d42baccf1ac1df53f4e77c577eda1c42237" Apr 15 18:18:18 125volumio go-librespot[1538]: time="2026-04-15T18:18:18+09:00" level=debug msg="resolved context of track" uri="spotify:track:0qpeVZuFuxrNvmT1FT60R7" Apr 15 18:18:18 125volumio go-librespot[1538]: panic: runtime error: invalid memory address or nil pointer dereference Apr 15 18:18:18 125volumio go-librespot[1538]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x45e5f4] Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 104 gp=0x14aab48 m=0 mp=0xce0d20 [running]: Apr 15 18:18:18 125volumio go-librespot[1538]: panic({0x6cfb00, 0xca02c0}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x132d5fc sp=0x132d5a8 pc=0x58bf8 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.panicmem(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/panic.go:261 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.sigpanic() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/signal_unix.go:881 +0x39c fp=0x132d62c sp=0x132d5fc pc=0x74be4 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot.ContextTrackToProvidedTrack({0x79177a, 0x5}, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ids.go:25 +0x14 fp=0x132d690 sp=0x132d630 pc=0x45e5f4 Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*AppPlayer).handlePlayerCommand(0x10d83c0, {0x8874f0, 0xd0ad00}, {0x106f2f79, {0x12bec00, 0x28}, {{0x1011520, 0x8}, {0x0, 0x0}, ...}}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/player.go:213 +0x18b4 fp=0x132d7b0 sp=0x132d690 pc=0x642a6c Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*AppPlayer).handleDealerRequest(0x10d83c0, {0x8874f0, 0xd0ad00}, {0x1356ac0, {0x12be2d0, 0x24}, {0x106f2f79, {0x12bec00, 0x28}, {{0x1011520, ...}, ...}}}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/player.go:374 +0x11c fp=0x132d8e4 sp=0x132d7b0 pc=0x6436ac Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*AppPlayer).Run(0x10d83c0, {0x8874f0, 0xd0ad00}, 0x1336700) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/player.go:602 +0x690 fp=0x132dfd8 sp=0x132d8e4 pc=0x645bdc Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*App).withAppPlayer.func3.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:358 +0x40 fp=0x132dfec sp=0x132dfd8 pc=0x63e298 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x132dfec sp=0x132dfec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by main.(*App).withAppPlayer.func3 in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:358 +0x584 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 1 gp=0x1002128 m=nil [select, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1226d30 sp=0x1226d1c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x1226e30, 0x1265dfc, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1226dd0 sp=0x1226d30 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x155e1e0, 0x1226ec0) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x1226e74 sp=0x1226dd0 pc=0x5a8088 Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*App).withAppPlayer(0x10beb80, {0x8874f0, 0xd0ad00}, 0x10b37b8) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:321 +0x554 fp=0x1226f00 sp=0x1226e74 pc=0x63db54 Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*App).Zeroconf(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:170 Apr 15 18:18:18 125volumio go-librespot[1538]: main.main() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:549 +0x7f4 fp=0x1226fa8 sp=0x1226f00 pc=0x640120 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.main() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x1226fec sp=0x1226fa8 pc=0x5cb30 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1226fec sp=0x1226fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 2 gp=0x1002c68 m=nil [force gc (idle), 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1044fd4 sp=0x1044fc0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goparkunlock(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.forcegchelper() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1044fec sp=0x1044fd4 pc=0x5cefc Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1044fec sp=0x1044fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.init.5 in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:314 +0x1c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 3 gp=0x1002d88 m=nil [GC sweep wait]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x10457c4 sp=0x10457b0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goparkunlock(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.bgsweep(0x1074000) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x10457e4 sp=0x10457c4 pc=0x45848 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcenable.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x10457ec sp=0x10457e4 pc=0x35968 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10457ec sp=0x10457ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcenable in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 4 gp=0x1002ea8 m=nil [GC scavenge wait]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1045fb4 sp=0x1045fa0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goparkunlock(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.(*scavengerState).park(0xce0208) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1045fc8 sp=0x1045fb4 pc=0x42b68 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.bgscavenge(0x1074000) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1045fe4 sp=0x1045fc8 pc=0x432a0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcenable.gowrap2() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1045fec sp=0x1045fe4 pc=0x35914 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1045fec sp=0x1045fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcenable in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 5 gp=0x1002fc8 m=nil [finalizer wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x104678c sp=0x1046778 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.runfinq() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x10467ec sp=0x104678c pc=0x34754 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10467ec sp=0x10467ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.createfing in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 20 gp=0x10859e8 m=nil [IO wait, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbef18, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1040528 sp=0x1040514 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbef08, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1040540 sp=0x1040528 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbef08, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1040554 sp=0x1040540 pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x10d91e8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1040568 sp=0x1040554 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Accept(0x10d91d0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x10405b0 sp=0x1040568 pc=0x10eb84 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).accept(0x10d91d0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1040618 sp=0x10405b0 pc=0x17e4c4 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPListener).accept(0x10ae6d8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1040630 sp=0x1040618 pc=0x196900 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPListener).Accept(0x10ae6d8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x104064c sp=0x1040630 pc=0x19596c Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*onceCloseListener).Accept(0x1294340) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x34 fp=0x1040664 sp=0x104064c pc=0x362b54 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*Server).Serve(0x128c0a8, {0x886cb8, 0x10ae6d8}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x10406fc sp=0x1040664 pc=0x341210 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.Serve(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2794 Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*ConcreteApiServer).serve(0x10d4f60) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x10407e4 sp=0x10406fc pc=0x6330b8 Apr 15 18:18:18 125volumio go-librespot[1538]: main.NewApiServer.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x10407ec sp=0x10407e4 pc=0x631de4 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10407ec sp=0x10407ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by main.NewApiServer in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:296 +0x310 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 53 gp=0x1085c28 m=nil [IO wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbed38, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1055e84 sp=0x1055e70 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbed28, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1055e9c sp=0x1055e84 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbed28, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1055eb0 sp=0x1055e9c pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x142c1f8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1055ec4 sp=0x1055eb0 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).RawRead(0x142c1e0, 0x1335980) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1055ef0 sp=0x1055ec4 pc=0x10f788 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*rawConn).Read(0x141e2a0, 0x1335980) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1055f10 sp=0x1055ef0 pc=0x190d28 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x135c2a0, 0x1335950, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1055f40 sp=0x1055f10 pc=0x548824 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x142a0f8, {0x14dc000, 0x10000, 0x10000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x1055f9c sp=0x1055f40 pc=0x54c80c Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/grandcat/zeroconf.(*Server).recv4(0x10b4740, 0x142a0f0) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1055fe0 sp=0x1055f9c pc=0x5a309c Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1055fec sp=0x1055fe0 pc=0x5a2d54 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1055fec sp=0x1055fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 8 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 35 gp=0x12f6008 m=nil [GC worker (idle)]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3fbc, 0x12ae378, 0x1a, 0xa, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1040f90 sp=0x1040f7c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcBgMarkWorker() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1040fec sp=0x1040f90 pc=0x38590 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1040fec sp=0x1040fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 36 gp=0x12f6128 m=nil [GC worker (idle), 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3fbc, 0x12ae390, 0x1a, 0xa, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fc790 sp=0x12fc77c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcBgMarkWorker() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x12fc7ec sp=0x12fc790 pc=0x38590 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fc7ec sp=0x12fc7ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 37 gp=0x12f6248 m=nil [GC worker (idle)]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3fbc, 0x12ae3a8, 0x1a, 0xa, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fcf90 sp=0x12fcf7c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcBgMarkWorker() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x12fcfec sp=0x12fcf90 pc=0x38590 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fcfec sp=0x12fcfec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 38 gp=0x12f6368 m=nil [GC worker (idle)]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3fbc, 0x12ae3c0, 0x1a, 0xa, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fd790 sp=0x12fd77c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gcBgMarkWorker() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x12fd7ec sp=0x12fd790 pc=0x38590 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fd7ec sp=0x12fd7ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 10 gp=0x12f6b48 m=nil [chan receive, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3f90, 0x10921f0, 0xe, 0x7, 0x2) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fdf48 sp=0x12fdf34 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv(0x10921c0, 0x12fdfd0, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x12fdf84 sp=0x12fdf48 pc=0x20078 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv2(0x10921c0, 0x12fdfd0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x12fdf98 sp=0x12fdf84 pc=0x1fbbc Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*App).withAppPlayer.func1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:268 +0x68 fp=0x12fdfec sp=0x12fdf98 pc=0x63e794 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fdfec sp=0x12fdfec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by main.(*App).withAppPlayer in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:265 +0x464 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 11 gp=0x12f6c68 m=nil [chan receive, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3f90, 0x10921b0, 0xe, 0x7, 0x2) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fe740 sp=0x12fe72c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv(0x1092180, 0x12fe7e0, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x12fe77c sp=0x12fe740 pc=0x20078 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv2(0x1092180, 0x12fe7e0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x12fe790 sp=0x12fe77c pc=0x1fbbc Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*App).withAppPlayer.func2() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:284 +0x6c fp=0x12fe7ec sp=0x12fe790 pc=0x63e330 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fe7ec sp=0x12fe7ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by main.(*App).withAppPlayer in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/main.go:281 +0x504 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 54 gp=0x1003328 m=nil [IO wait, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbec98, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x104765c sp=0x1047648 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbec88, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1047674 sp=0x104765c pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbec88, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1047688 sp=0x1047674 pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x142c248, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x104769c sp=0x1047688 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).RawRead(0x142c230, 0x11306f0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x10476c8 sp=0x104769c pc=0x10f788 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*rawConn).Read(0x141e2c0, 0x11306f0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x10476e8 sp=0x10476c8 pc=0x190d28 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x135c2b0, 0x11306c0, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1047718 sp=0x10476e8 pc=0x548824 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Apr 15 18:18:18 125volumio go-librespot[1538]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x142a128, {0x1214000, 0x10000, 0x10000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x104779c sp=0x1047718 pc=0x550194 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/grandcat/zeroconf.(*Server).recv6(0x10b4740, 0x142a120) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x10477e0 sp=0x104779c pc=0x5a3290 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x10477ec sp=0x10477e0 pc=0x5a2cf8 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10477ec sp=0x10477ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 8 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 12 gp=0x12f6d88 m=nil [IO wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbedd8, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fede8 sp=0x12fedd4 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbedc8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x12fee00 sp=0x12fede8 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbedc8, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x12fee14 sp=0x12fee00 pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x142c1a8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x12fee28 sp=0x12fee14 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Accept(0x142c190) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x12fee70 sp=0x12fee28 pc=0x10eb84 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).accept(0x142c190) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x12feed8 sp=0x12fee70 pc=0x17e4c4 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPListener).accept(0x14181b0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x12feef0 sp=0x12feed8 pc=0x196900 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPListener).Accept(0x14181b0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x12fef0c sp=0x12feef0 pc=0x19596c Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*onceCloseListener).Accept(0x1076500) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x34 fp=0x12fef24 sp=0x12fef0c pc=0x362b54 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*Server).Serve(0x11021e8, {0x886cb8, 0x14181b0}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x12fefbc sp=0x12fef24 pc=0x341210 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.Serve(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2794 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x12fefec sp=0x12fefbc pc=0x5a8184 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fefec sp=0x12fefec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/zeroconf/zeroconf.go:280 +0x160 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 103 gp=0x14aa128 m=nil [select, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1044674 sp=0x1044660 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x1044774, 0x104473c, 0x0, 0x0, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1044714 sp=0x1044674 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1354230) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/player/player.go:201 +0x1fc fp=0x10447e4 sp=0x1044714 pc=0x513660 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/player/player.go:183 +0x28 fp=0x10447ec sp=0x10447e4 pc=0x513240 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10447ec sp=0x10447ec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/player/player.go:183 +0x218 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 41 gp=0x14aa248 m=nil [IO wait, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbebf8, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x122b87c sp=0x122b868 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbebe8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x122b894 sp=0x122b87c pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbebe8, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x122b8a8 sp=0x122b894 pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x123a1a8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x122b8bc sp=0x122b8a8 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Read(0x123a190, {0x125c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x122b904 sp=0x122b8bc pc=0x10b504 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).Read(0x123a190, {0x125c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x122b930 sp=0x122b904 pc=0x17c5d0 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*conn).Read(0x120e8a8, {0x125c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x122b95c sp=0x122b930 pc=0x18caec Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPConn).Read(0x120e8a8, {0x125c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x44 fp=0x122b97c sp=0x122b95c pc=0x19fd40 Apr 15 18:18:18 125volumio go-librespot[1538]: io.(*multiReader).Read(0x10a3240, {0x125c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x122b9a8 sp=0x122b97c pc=0x105528 Apr 15 18:18:18 125volumio go-librespot[1538]: bufio.(*Reader).fill(0x1238330) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x122b9cc sp=0x122b9a8 pc=0x2bddb4 Apr 15 18:18:18 125volumio go-librespot[1538]: bufio.(*Reader).ReadByte(0x1238330) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x122b9d8 sp=0x122b9cc pc=0x2be638 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.readFrameHeader(0x1238330, {0x11ee538, 0x8, 0x8}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x122ba18 sp=0x122b9d8 pc=0x47788c Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x11ee508, {0x8874d0, 0xd0ad00}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x122bad8 sp=0x122ba18 pc=0x47a4f0 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).readLoop(0x11ee508, {0x8874d0, 0xd0ad00}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x122bb9c sp=0x122bad8 pc=0x479fd8 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).reader(0x11ee508, {0x8874d0, 0xd0ad00}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x122bc28 sp=0x122bb9c pc=0x47b1ec Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).Reader(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).Read(0x11ee508, {0x8874d0, 0xd0ad00}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x122bc50 sp=0x122bc28 pc=0x4798bc Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x122bccc sp=0x122bc50 pc=0x633988 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.HandlerFunc.ServeHTTP(0x128a180, {0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x122bcdc sp=0x122bccc pc=0x33d7f4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*ServeMux).ServeHTTP(0x1280000, {0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x122bd18 sp=0x122bcdc pc=0x33f654 Apr 15 18:18:18 125volumio go-librespot[1538]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x122bd40 sp=0x122bd18 pc=0x633388 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.HandlerFunc.ServeHTTP(0x1284160, {0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x122bd50 sp=0x122bd40 pc=0x33d7f4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.serverHandler.ServeHTTP({0x128c0a8}, {0x886dec, 0x120c468}, 0x120c3c8) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x122bd6c sp=0x122bd50 pc=0x340de4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*conn).serve(0x10288a0, {0x887510, 0x1296180}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x122bfdc sp=0x122bd6c pc=0x33c034 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*Server).Serve.gowrap3() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x122bfec sp=0x122bfdc pc=0x341688 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x122bfec sp=0x122bfec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by net/http.(*Server).Serve in goroutine 20 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/server.go:3285 +0x468 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 43 gp=0x14aa6c8 m=nil [select, 3 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12fbea8 sp=0x12fbe94 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x12fbfa4, 0x12fbf6c, 0x0, 0x0, 0x5, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x12fbf48 sp=0x12fbea8 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x11ee508) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x12fbfe4 sp=0x12fbf48 pc=0x474738 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.newConn.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x12fbfec sp=0x12fbfe4 pc=0x47432c Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fbfec sp=0x12fbfec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by nhooyr.io/websocket.newConn in goroutine 41 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 75 gp=0x12f6488 m=nil [select, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1041e98 sp=0x1041e84 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x1041fd4, 0x1041f60, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1041f38 sp=0x1041e98 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x1166428) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:138 +0x8c fp=0x1041fe4 sp=0x1041f38 pc=0x5318dc Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:129 +0x28 fp=0x1041fec sp=0x1041fe4 pc=0x5337e8 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1041fec sp=0x1041fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 104 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:129 +0x15c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 101 gp=0x12f66c8 m=nil [IO wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbea18, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1224ad4 sp=0x1224ac0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbea08, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1224aec sp=0x1224ad4 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbea08, 0x72) Apr 15 18:18:18 125volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1224b00 sp=0x1224aec pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x131b1e8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1224b14 sp=0x1224b00 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Read(0x131b1d0, {0x1303000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1224b5c sp=0x1224b14 pc=0x10b504 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).Read(0x131b1d0, {0x1303000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1224b88 sp=0x1224b5c pc=0x17c5d0 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*conn).Read(0x128a048, {0x1303000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1224bb4 sp=0x1224b88 pc=0x18caec Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPConn).Read(0x128a048, {0x1303000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x44 fp=0x1224bd4 sp=0x1224bb4 pc=0x19fd40 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*atLeastReader).Read(0x13072c0, {0x1303000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1224c00 sp=0x1224bd4 pc=0x27c680 Apr 15 18:18:18 125volumio go-librespot[1538]: bytes.(*Buffer).ReadFrom(0x12b218c, {0x883674, 0x13072c0}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1224c3c sp=0x1224c00 pc=0x139bd0 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readFromUntil(0x12b2008, {0x882848, 0x128a048}, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1224c64 sp=0x1224c3c pc=0x27c8dc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecordOrCCS(0x12b2008, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1224dc8 sp=0x1224c64 pc=0x279fdc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).Read(0x12b2008, {0x1339000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1224df8 sp=0x1224dc8 pc=0x27fe4c Apr 15 18:18:18 125volumio go-librespot[1538]: bufio.(*Reader).Read(0x1334420, {0x115a2a4, 0x9, 0x9}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1224e1c sp=0x1224df8 pc=0x2be440 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadAtLeast({0x882a3c, 0x1334420}, {0x115a2a4, 0x9, 0x9}, 0x9) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1224e48 sp=0x1224e1c pc=0x1042c0 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadFull(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:18 125volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 18:18:18 125volumio volumio[1150]: info: Connection to go-librespot Websocket closed Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.http2readFrameHeader({0x115a2a4, 0x9, 0x9}, {0x882a3c, 0x1334420}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1224e70 sp=0x1224e48 pc=0x2f733c Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Framer).ReadFrame(0x115a280) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1224eec sp=0x1224e70 pc=0x2f7ad4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2clientConnReadLoop).run(0x1224fdc) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1224fa4 sp=0x1224eec pc=0x31c2f0 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2ClientConn).readLoop(0x10edd08) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1224fe4 sp=0x1224fa4 pc=0x31b7e4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1224fec sp=0x1224fe4 pc=0x314830 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1224fec sp=0x1224fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by net/http.(*http2Transport).newClientConn in goroutine 100 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 82 gp=0x14aad88 m=nil [IO wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbeb58, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1056ad4 sp=0x1056ac0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbeb48, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1056aec sp=0x1056ad4 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbeb48, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1056b00 sp=0x1056aec pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x123a158, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1056b14 sp=0x1056b00 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Read(0x123a140, {0x1466000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1056b5c sp=0x1056b14 pc=0x10b504 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).Read(0x123a140, {0x1466000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1056b88 sp=0x1056b5c pc=0x17c5d0 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*conn).Read(0x141e978, {0x1466000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1056bb4 sp=0x1056b88 pc=0x18caec Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPConn).Read(0x141e978, {0x1466000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x44 fp=0x1056bd4 sp=0x1056bb4 pc=0x19fd40 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*atLeastReader).Read(0x135ca60, {0x1466000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1056c00 sp=0x1056bd4 pc=0x27c680 Apr 15 18:18:18 125volumio go-librespot[1538]: bytes.(*Buffer).ReadFrom(0x123da4c, {0x883674, 0x135ca60}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1056c3c sp=0x1056c00 pc=0x139bd0 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readFromUntil(0x123d8c8, {0x882848, 0x141e978}, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1056c64 sp=0x1056c3c pc=0x27c8dc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecordOrCCS(0x123d8c8, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1056dc8 sp=0x1056c64 pc=0x279fdc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).Read(0x123d8c8, {0x1474000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1056df8 sp=0x1056dc8 pc=0x27fe4c Apr 15 18:18:18 125volumio go-librespot[1538]: bufio.(*Reader).Read(0x142b5f0, {0x1280124, 0x9, 0x9}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1056e1c sp=0x1056df8 pc=0x2be440 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadAtLeast({0x882a3c, 0x142b5f0}, {0x1280124, 0x9, 0x9}, 0x9) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1056e48 sp=0x1056e1c pc=0x1042c0 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadFull(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.http2readFrameHeader({0x1280124, 0x9, 0x9}, {0x882a3c, 0x142b5f0}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1056e70 sp=0x1056e48 pc=0x2f733c Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Framer).ReadFrame(0x1280100) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1056eec sp=0x1056e70 pc=0x2f7ad4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2clientConnReadLoop).run(0x1056fdc) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1056fa4 sp=0x1056eec pc=0x31c2f0 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2ClientConn).readLoop(0x1448108) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1056fe4 sp=0x1056fa4 pc=0x31b7e4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1056fec sp=0x1056fe4 pc=0x314830 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1056fec sp=0x1056fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by net/http.(*http2Transport).newClientConn in goroutine 16 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 74 gp=0x12bc128 m=nil [chan receive]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e3f90, 0x1356af0, 0xe, 0x7, 0x2) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1035d60 sp=0x1035d4c pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv(0x1356ac0, 0x1035ddb, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1035d9c sp=0x1035d60 pc=0x20078 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.chanrecv1(0x1356ac0, 0x1035ddb) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x1035db0 sp=0x1035d9c pc=0x1fb98 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x1166428, 0x12d2370) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/recv.go:237 +0x1f8 fp=0x1035f2c sp=0x1035db0 pc=0x533ab4 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1166428) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:213 +0x4d8 fp=0x1035fe4 sp=0x1035f2c pc=0x5321e4 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:125 +0x28 fp=0x1035fec sp=0x1035fe4 pc=0x53383c Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1035fec sp=0x1035fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 104 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/dealer/dealer.go:125 +0x98 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 73 gp=0x12bc248 m=nil [select, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1047ea8 sp=0x1047e94 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x1047fa4, 0x1047f6c, 0x0, 0x0, 0x5, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1047f48 sp=0x1047ea8 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x11ee788) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1047fe4 sp=0x1047f48 pc=0x474738 Apr 15 18:18:18 125volumio go-librespot[1538]: nhooyr.io/websocket.newConn.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1047fec sp=0x1047fe4 pc=0x47432c Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1047fec sp=0x1047fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by nhooyr.io/websocket.newConn in goroutine 104 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 114 gp=0x12bc488 m=nil [IO wait, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbeab8, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12e2d14 sp=0x12e2d00 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbeaa8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x12e2d2c sp=0x12e2d14 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbeaa8, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x12e2d40 sp=0x12e2d2c pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x123add8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x12e2d54 sp=0x12e2d40 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Read(0x123adc0, {0x1010a00, 0x3, 0x3}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x12e2d9c sp=0x12e2d54 pc=0x10b504 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).Read(0x123adc0, {0x1010a00, 0x3, 0x3}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x12e2dc8 sp=0x12e2d9c pc=0x17c5d0 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*conn).Read(0x10b2c10, {0x1010a00, 0x3, 0x3}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x12e2df4 sp=0x12e2dc8 pc=0x18caec Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPConn).Read(0x10b2c10, {0x1010a00, 0x3, 0x3}) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x44 fp=0x12e2e14 sp=0x12e2df4 pc=0x19fd40 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadAtLeast({0x882848, 0x10b2c10}, {0x1010a00, 0x3, 0x3}, 0x3) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x12e2e40 sp=0x12e2e14 pc=0x1042c0 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadFull(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x124d140, {0x8874f0, 0xd0ad00}) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/shannon.go:124 +0x3a0 fp=0x12e2f04 sp=0x12e2e40 pc=0x48faf4 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1166008) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:276 +0x68 fp=0x12e2fe4 sp=0x12e2f04 pc=0x48c330 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:260 +0x28 fp=0x12e2fec sp=0x12e2fe4 pc=0x48c29c Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12e2fec sp=0x12e2fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 104 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:260 +0x98 Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 115 gp=0x12bc6c8 m=nil [select, 1 minutes]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12ffeb8 sp=0x12ffea4 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.selectgo(0x12fffd4, 0x12fff7c, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x12fff58 sp=0x12ffeb8 pc=0x70e78 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x1166008) Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:355 +0x8c fp=0x12fffe4 sp=0x12fff58 pc=0x48cb50 Apr 15 18:18:18 125volumio go-librespot[1538]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:264 +0x28 fp=0x12fffec sp=0x12fffe4 pc=0x48c248 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12fffec sp=0x12fffec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 104 Apr 15 18:18:18 125volumio go-librespot[1538]: /src/ap/ap.go:264 +0x15c Apr 15 18:18:18 125volumio go-librespot[1538]: goroutine 117 gp=0x13bf568 m=nil [IO wait]: Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.gopark(0x7e40f0, 0xb4fbe978, 0x2, 0x2, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1229ad4 sp=0x1229ac0 pc=0x5d0c0 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.netpollblock(0xb4fbe968, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1229aec sp=0x1229ad4 pc=0x548cc Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.runtime_pollWait(0xb4fbe968, 0x72) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1229b00 sp=0x1229aec pc=0x8f4a8 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).wait(0x13e41f8, 0x72, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1229b14 sp=0x1229b00 pc=0x10a318 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:18 125volumio go-librespot[1538]: internal/poll.(*FD).Read(0x13e41e0, {0x12ec000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1229b5c sp=0x1229b14 pc=0x10b504 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*netFD).Read(0x13e41e0, {0x12ec000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1229b88 sp=0x1229b5c pc=0x17c5d0 Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*conn).Read(0x1318c40, {0x12ec000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1229bb4 sp=0x1229b88 pc=0x18caec Apr 15 18:18:18 125volumio go-librespot[1538]: net.(*TCPConn).Read(0x1318c40, {0x12ec000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: :1 +0x44 fp=0x1229bd4 sp=0x1229bb4 pc=0x19fd40 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*atLeastReader).Read(0x129f020, {0x12ec000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1229c00 sp=0x1229bd4 pc=0x27c680 Apr 15 18:18:18 125volumio go-librespot[1538]: bytes.(*Buffer).ReadFrom(0x116538c, {0x883674, 0x129f020}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1229c3c sp=0x1229c00 pc=0x139bd0 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readFromUntil(0x1165208, {0x882848, 0x1318c40}, 0x5) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1229c64 sp=0x1229c3c pc=0x27c8dc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecordOrCCS(0x1165208, 0x0) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1229dc8 sp=0x1229c64 pc=0x279fdc Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:18 125volumio go-librespot[1538]: crypto/tls.(*Conn).Read(0x1165208, {0x140c000, 0x1000, 0x1000}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1229df8 sp=0x1229dc8 pc=0x27fe4c Apr 15 18:18:18 125volumio go-librespot[1538]: bufio.(*Reader).Read(0x12ad5c0, {0x12da124, 0x9, 0x9}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1229e1c sp=0x1229df8 pc=0x2be440 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadAtLeast({0x882a3c, 0x12ad5c0}, {0x12da124, 0x9, 0x9}, 0x9) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1229e48 sp=0x1229e1c pc=0x1042c0 Apr 15 18:18:18 125volumio go-librespot[1538]: io.ReadFull(...) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.http2readFrameHeader({0x12da124, 0x9, 0x9}, {0x882a3c, 0x12ad5c0}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1229e70 sp=0x1229e48 pc=0x2f733c Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Framer).ReadFrame(0x12da100) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1229eec sp=0x1229e70 pc=0x2f7ad4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2clientConnReadLoop).run(0x1229fdc) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1229fa4 sp=0x1229eec pc=0x31c2f0 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2ClientConn).readLoop(0x140a008) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1229fe4 sp=0x1229fa4 pc=0x31b7e4 Apr 15 18:18:18 125volumio go-librespot[1538]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1229fec sp=0x1229fe4 pc=0x314830 Apr 15 18:18:18 125volumio go-librespot[1538]: runtime.goexit({}) Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1229fec sp=0x1229fec pc=0x93d6c Apr 15 18:18:18 125volumio go-librespot[1538]: created by net/http.(*http2Transport).newClientConn in goroutine 116 Apr 15 18:18:18 125volumio go-librespot[1538]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:18 125volumio go-librespot[1537]: Aborted Apr 15 18:18:21 125volumio volumio[1150]: info: Initializing connection to go-librespot Websocket Apr 15 18:18:21 125volumio volumio[1150]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 18:18:21 125volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Apr 15 18:18:21 125volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 15 18:18:21 125volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 15 18:18:21 125volumio go-librespot[2097]: go-librespot daemon starting... Apr 15 18:18:21 125volumio go-librespot[2098]: time="2026-04-15T18:18:21+09:00" level=info msg="running go-librespot 0.4.0" Apr 15 18:18:21 125volumio go-librespot[2098]: time="2026-04-15T18:18:21+09:00" level=debug msg="app state loaded" Apr 15 18:18:21 125volumio go-librespot[2098]: time="2026-04-15T18:18:21+09:00" level=debug msg="stored credentials not found" Apr 15 18:18:21 125volumio go-librespot[2098]: time="2026-04-15T18:18:21+09:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 15 18:18:22 125volumio go-librespot[2098]: time="2026-04-15T18:18:22+09:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 15 18:18:22 125volumio go-librespot[2098]: time="2026-04-15T18:18:22+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 15 18:18:22 125volumio go-librespot[2098]: time="2026-04-15T18:18:22+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 15 18:18:22 125volumio go-librespot[2098]: time="2026-04-15T18:18:22+09:00" level=info msg="zeroconf server listening on port 36897" Apr 15 18:18:24 125volumio volumio[1150]: info: Initializing connection to go-librespot Websocket Apr 15 18:18:24 125volumio go-librespot[2098]: time="2026-04-15T18:18:24+09:00" level=debug msg="new websocket client" Apr 15 18:18:24 125volumio volumio[1150]: info: Connection to go-librespot Websocket established Apr 15 18:18:24 125volumio go-librespot[2098]: time="2026-04-15T18:18:24+09:00" level=debug msg="obtained new client token: AABPEVugHVDLHsNqcHXkSJhg2KTwzUkSck0AgXLa2zirJ1DAq8kUHrhcRpMtHmN7cy0yKC10jN4/gB3XvbbGNPaQY6bIbolEhFPGdhJePoAThLSh5/w+8Fv9XbOYCQqw30zsgKTg2NDaa93a9Rt5P61GL2934xQgWgi9e9M4zB7r75ORvJkMWY7/3a0SWFL966csoeMRt9b+U8s1Z6YkWdvUjWhN3knbYKofjXKYd7FU+pBTD2Vd/odCBt7K" Apr 15 18:18:24 125volumio go-librespot[2098]: time="2026-04-15T18:18:24+09:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="completed keyexchange" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="completed challenge" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=info msg="authenticated AP" username="d9*********************gh" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=info msg="authenticated Login5" username="d9*********************gh" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=info msg="accepted zeroconf from RYU-PC" username="d9*********************gh" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="dealer connection opened" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=trace msg="starting accesspoint recv loop" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=trace msg="starting dealer recv loop" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=trace msg="received accesspoint ping" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 15 18:18:25 125volumio go-librespot[2098]: time="2026-04-15T18:18:25+09:00" level=debug msg="received connection id: Zjc4OTBhNjQtM2Iw...RDdFQUVFODJGOQ==" Apr 15 18:18:26 125volumio go-librespot[2098]: time="2026-04-15T18:18:26+09:00" level=debug msg="put connect state because NEW_DEVICE" Apr 15 18:18:26 125volumio go-librespot[2098]: time="2026-04-15T18:18:26+09:00" level=trace msg="received accesspoint pong ack" Apr 15 18:18:26 125volumio go-librespot[2098]: time="2026-04-15T18:18:26+09:00" level=debug msg="handling transfer player command from 5b7a5d42baccf1ac1df53f4e77c577eda1c42237" Apr 15 18:18:26 125volumio go-librespot[2098]: time="2026-04-15T18:18:26+09:00" level=debug msg="resolved context of track" uri="spotify:track:0qpeVZuFuxrNvmT1FT60R7" Apr 15 18:18:26 125volumio go-librespot[2098]: panic: runtime error: invalid memory address or nil pointer dereference Apr 15 18:18:26 125volumio go-librespot[2098]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x45e5f4] Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 42 gp=0x1896c68 m=4 mp=0x1449088 [running]: Apr 15 18:18:26 125volumio go-librespot[2098]: panic({0x6cfb00, 0xca02c0}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x15575fc sp=0x15575a8 pc=0x58bf8 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.panicmem(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/panic.go:261 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.sigpanic() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/signal_unix.go:881 +0x39c fp=0x155762c sp=0x15575fc pc=0x74be4 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot.ContextTrackToProvidedTrack({0x79177a, 0x5}, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ids.go:25 +0x14 fp=0x1557690 sp=0x1557630 pc=0x45e5f4 Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*AppPlayer).handlePlayerCommand(0x15cb450, {0x8874f0, 0xd0ad00}, {0x106f4f05, {0x192cc60, 0x28}, {{0x1903a30, 0x8}, {0x0, 0x0}, ...}}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/player.go:213 +0x18b4 fp=0x15577b0 sp=0x1557690 pc=0x642a6c Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*AppPlayer).handleDealerRequest(0x15cb450, {0x8874f0, 0xd0ad00}, {0x1900900, {0x192c090, 0x24}, {0x106f4f05, {0x192cc60, 0x28}, {{0x1903a30, ...}, ...}}}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/player.go:374 +0x11c fp=0x15578e4 sp=0x15577b0 pc=0x6436ac Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*AppPlayer).Run(0x15cb450, {0x8874f0, 0xd0ad00}, 0x16f66c0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/player.go:602 +0x690 fp=0x1557fd8 sp=0x15578e4 pc=0x645bdc Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*App).withAppPlayer.func3.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:358 +0x40 fp=0x1557fec sp=0x1557fd8 pc=0x63e298 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1557fec sp=0x1557fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by main.(*App).withAppPlayer.func3 in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:358 +0x584 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 1 gp=0x1402128 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1455d30 sp=0x1455d1c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x1455e30, 0x1555dfc, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1455dd0 sp=0x1455d30 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x15a2660, 0x1455ec0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x1455e74 sp=0x1455dd0 pc=0x5a8088 Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*App).withAppPlayer(0x159c300, {0x8874f0, 0xd0ad00}, 0x15bf568) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:321 +0x554 fp=0x1455f00 sp=0x1455e74 pc=0x63db54 Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*App).Zeroconf(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:170 Apr 15 18:18:26 125volumio go-librespot[2098]: main.main() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:549 +0x7f4 fp=0x1455fa8 sp=0x1455f00 pc=0x640120 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.main() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x1455fec sp=0x1455fa8 pc=0x5cb30 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1455fec sp=0x1455fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 2 gp=0x14027e8 m=nil [force gc (idle)]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1444fd4 sp=0x1444fc0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goparkunlock(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.forcegchelper() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1444fec sp=0x1444fd4 pc=0x5cefc Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1444fec sp=0x1444fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.init.5 in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:314 +0x1c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 3 gp=0x1402d88 m=nil [GC sweep wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14457c4 sp=0x14457b0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goparkunlock(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.bgsweep(0x1474000) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x14457e4 sp=0x14457c4 pc=0x45848 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcenable.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x14457ec sp=0x14457e4 pc=0x35968 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14457ec sp=0x14457ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcenable in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 4 gp=0x1402ea8 m=nil [GC scavenge wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1445fb4 sp=0x1445fa0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goparkunlock(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:408 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.(*scavengerState).park(0xce0208) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1445fc8 sp=0x1445fb4 pc=0x42b68 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.bgscavenge(0x1474000) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1445fe4 sp=0x1445fc8 pc=0x432a0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcenable.gowrap2() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1445fec sp=0x1445fe4 pc=0x35914 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1445fec sp=0x1445fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcenable in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 5 gp=0x1403208 m=nil [finalizer wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x144678c sp=0x1446778 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.runfinq() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x14467ec sp=0x144678c pc=0x34754 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14467ec sp=0x14467ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.createfing in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 20 gp=0x15850e8 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091f08, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1440d28 sp=0x1440d14 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091ef8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1440d40 sp=0x1440d28 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091ef8, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1440d54 sp=0x1440d40 pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x15caf68, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1440d68 sp=0x1440d54 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Accept(0x15caf50) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1440db0 sp=0x1440d68 pc=0x10eb84 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).accept(0x15caf50) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1440e18 sp=0x1440db0 pc=0x17e4c4 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPListener).accept(0x1594498) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1440e30 sp=0x1440e18 pc=0x196900 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPListener).Accept(0x1594498) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1440e4c sp=0x1440e30 pc=0x19596c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*onceCloseListener).Accept(0x1634340) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x34 fp=0x1440e64 sp=0x1440e4c pc=0x362b54 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*Server).Serve(0x162c0a8, {0x886cb8, 0x1594498}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1440efc sp=0x1440e64 pc=0x341210 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.Serve(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2794 Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*ConcreteApiServer).serve(0x15a2780) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x1440fe4 sp=0x1440efc pc=0x6330b8 Apr 15 18:18:26 125volumio go-librespot[2098]: main.NewApiServer.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x1440fec sp=0x1440fe4 pc=0x631de4 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1440fec sp=0x1440fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by main.NewApiServer in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/api_server.go:296 +0x310 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 10 gp=0x1585448 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091e68, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16f2ad4 sp=0x16f2ac0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091e58, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x16f2aec sp=0x16f2ad4 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091e58, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x16f2b00 sp=0x16f2aec pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x15cb0f8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x16f2b14 sp=0x16f2b00 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x15cb0e0, {0x15fe000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x16f2b5c sp=0x16f2b14 pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x15cb0e0, {0x15fe000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x16f2b88 sp=0x16f2b5c pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x14302c0, {0x15fe000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x16f2bb4 sp=0x16f2b88 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x14302c0, {0x15fe000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x16f2bd4 sp=0x16f2bb4 pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*atLeastReader).Read(0x15a7540, {0x15fe000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x16f2c00 sp=0x16f2bd4 pc=0x27c680 Apr 15 18:18:26 125volumio go-librespot[2098]: bytes.(*Buffer).ReadFrom(0x1496a8c, {0x883674, 0x15a7540}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x16f2c3c sp=0x16f2c00 pc=0x139bd0 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readFromUntil(0x1496908, {0x882848, 0x14302c0}, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x16f2c64 sp=0x16f2c3c pc=0x27c8dc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecordOrCCS(0x1496908, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x16f2dc8 sp=0x16f2c64 pc=0x279fdc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).Read(0x1496908, {0x14dd000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x16f2df8 sp=0x16f2dc8 pc=0x27fe4c Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).Read(0x160adb0, {0x159c0a4, 0x9, 0x9}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x16f2e1c sp=0x16f2df8 pc=0x2be440 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadAtLeast({0x882a3c, 0x160adb0}, {0x159c0a4, 0x9, 0x9}, 0x9) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x16f2e48 sp=0x16f2e1c pc=0x1042c0 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadFull(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.http2readFrameHeader({0x159c0a4, 0x9, 0x9}, {0x882a3c, 0x160adb0}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x16f2e70 sp=0x16f2e48 pc=0x2f733c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Framer).ReadFrame(0x159c080) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x16f2eec sp=0x16f2e70 pc=0x2f7ad4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2clientConnReadLoop).run(0x16f2fdc) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x16f2fa4 sp=0x16f2eec pc=0x31c2f0 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2ClientConn).readLoop(0x14bfd08) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x16f2fe4 sp=0x16f2fa4 pc=0x31b7e4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x16f2fec sp=0x16f2fe4 pc=0x314830 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16f2fec sp=0x16f2fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by net/http.(*http2Transport).newClientConn in goroutine 9 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 26 gp=0x1585688 m=nil [GC worker (idle)]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3fbc, 0x142a4e0, 0x1a, 0xa, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1441790 sp=0x144177c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcBgMarkWorker() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x14417ec sp=0x1441790 pc=0x38590 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14417ec sp=0x14417ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 8 gp=0x1403d48 m=nil [GC worker (idle)]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3fbc, 0x1644000, 0x1a, 0xa, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1444790 sp=0x144477c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcBgMarkWorker() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x14447ec sp=0x1444790 pc=0x38590 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14447ec sp=0x14447ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 34 gp=0x1646008 m=nil [GC worker (idle)]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3fbc, 0x142a4f8, 0x1a, 0xa, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164c790 sp=0x164c77c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcBgMarkWorker() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x164c7ec sp=0x164c790 pc=0x38590 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164c7ec sp=0x164c7ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 27 gp=0x15857a8 m=nil [GC worker (idle)]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3fbc, 0x1644018, 0x1a, 0xa, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1441f90 sp=0x1441f7c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gcBgMarkWorker() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1441fec sp=0x1441f90 pc=0x38590 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1441fec sp=0x1441fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by runtime.gcBgMarkStartWorkers in goroutine 6 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 55 gp=0x16465a8 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164b6a8 sp=0x164b694 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x164b7a4, 0x164b76c, 0x0, 0x0, 0x5, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x164b748 sp=0x164b6a8 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x159e3c8) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x164b7e4 sp=0x164b748 pc=0x474738 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.newConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x164b7ec sp=0x164b7e4 pc=0x47432c Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164b7ec sp=0x164b7ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by nhooyr.io/websocket.newConn in goroutine 73 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 30 gp=0x16467e8 m=nil [chan receive]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3f90, 0x15ea0b0, 0xe, 0x7, 0x2) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164cf48 sp=0x164cf34 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv(0x15ea080, 0x164cfd0, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x164cf84 sp=0x164cf48 pc=0x20078 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv2(0x15ea080, 0x164cfd0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x164cf98 sp=0x164cf84 pc=0x1fbbc Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*App).withAppPlayer.func1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:268 +0x68 fp=0x164cfec sp=0x164cf98 pc=0x63e794 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164cfec sp=0x164cfec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by main.(*App).withAppPlayer in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:265 +0x464 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 31 gp=0x1646908 m=nil [chan receive]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3f90, 0x15ea070, 0xe, 0x7, 0x2) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164d740 sp=0x164d72c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv(0x15ea040, 0x164d7e0, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x164d77c sp=0x164d740 pc=0x20078 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv2(0x15ea040, 0x164d7e0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x164d790 sp=0x164d77c pc=0x1fbbc Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*App).withAppPlayer.func2() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:284 +0x6c fp=0x164d7ec sp=0x164d790 pc=0x63e330 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164d7ec sp=0x164d7ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by main.(*App).withAppPlayer in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/main.go:281 +0x504 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 32 gp=0x1646a28 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091dc8, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164dde8 sp=0x164ddd4 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091db8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x164de00 sp=0x164dde8 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091db8, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x164de14 sp=0x164de00 pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x173a0b8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x164de28 sp=0x164de14 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Accept(0x173a0a0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x164de70 sp=0x164de28 pc=0x10eb84 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).accept(0x173a0a0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x164ded8 sp=0x164de70 pc=0x17e4c4 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPListener).accept(0x173e0a8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x164def0 sp=0x164ded8 pc=0x196900 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPListener).Accept(0x173e0a8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x164df0c sp=0x164def0 pc=0x19596c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*onceCloseListener).Accept(0x17924e0) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x34 fp=0x164df24 sp=0x164df0c pc=0x362b54 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*Server).Serve(0x153a008, {0x886cb8, 0x173e0a8}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x164dfbc sp=0x164df24 pc=0x341210 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.Serve(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2794 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x164dfec sp=0x164dfbc pc=0x5a8184 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164dfec sp=0x164dfec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/zeroconf/zeroconf.go:280 +0x160 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 33 gp=0x1646b48 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091d28, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16eee84 sp=0x16eee70 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091d18, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x16eee9c sp=0x16eee84 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091d18, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x16eeeb0 sp=0x16eee9c pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x173a108, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x16eeec4 sp=0x16eeeb0 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).RawRead(0x173a0f0, 0x18e2930) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x16eeef0 sp=0x16eeec4 pc=0x10f788 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*rawConn).Read(0x15be250, 0x18e2930) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x16eef10 sp=0x16eeef0 pc=0x190d28 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x16ea210, 0x18e2900, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x16eef40 sp=0x16eef10 pc=0x548824 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x1878098, {0x17c4000, 0x10000, 0x10000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x16eef9c sp=0x16eef40 pc=0x54c80c Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/grandcat/zeroconf.(*Server).recv4(0x15c6580, 0x1878090) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x16eefe0 sp=0x16eef9c pc=0x5a309c Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x16eefec sp=0x16eefe0 pc=0x5a2d54 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16eefec sp=0x16eefec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 28 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 50 gp=0x1646c68 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091c88, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164ee5c sp=0x164ee48 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091c78, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x164ee74 sp=0x164ee5c pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091c78, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x164ee88 sp=0x164ee74 pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x173a158, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x164ee9c sp=0x164ee88 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).RawRead(0x173a140, 0x1878180) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x164eec8 sp=0x164ee9c pc=0x10f788 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*rawConn).Read(0x15be270, 0x1878180) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x164eee8 sp=0x164eec8 pc=0x190d28 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x16ea220, 0x1878150, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x164ef18 sp=0x164eee8 pc=0x548824 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Apr 15 18:18:26 125volumio go-librespot[2098]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x18780c8, {0x17a6000, 0x10000, 0x10000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x164ef9c sp=0x164ef18 pc=0x550194 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/grandcat/zeroconf.(*Server).recv6(0x15c6580, 0x18780c0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x164efe0 sp=0x164ef9c pc=0x5a3290 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x164efec sp=0x164efe0 pc=0x5a2cf8 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164efec sp=0x164efec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 28 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 73 gp=0x1584b48 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091aa8, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x145987c sp=0x1459868 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091a98, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1459894 sp=0x145987c pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091a98, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x14598a8 sp=0x1459894 pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x16650a8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x14598bc sp=0x14598a8 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x1665090, {0x167b000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1459904 sp=0x14598bc pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x1665090, {0x167b000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1459930 sp=0x1459904 pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x1431908, {0x167b000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x145995c sp=0x1459930 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x1431908, {0x167b000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x145997c sp=0x145995c pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: io.(*multiReader).Read(0x16ea490, {0x167b000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x14599a8 sp=0x145997c pc=0x105528 Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).fill(0x166a960) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x14599cc sp=0x14599a8 pc=0x2bddb4 Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).ReadByte(0x166a960) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x14599d8 sp=0x14599cc pc=0x2be638 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.readFrameHeader(0x166a960, {0x159e3f8, 0x8, 0x8}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1459a18 sp=0x14599d8 pc=0x47788c Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x159e3c8, {0x8874d0, 0xd0ad00}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1459ad8 sp=0x1459a18 pc=0x47a4f0 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).readLoop(0x159e3c8, {0x8874d0, 0xd0ad00}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1459b9c sp=0x1459ad8 pc=0x479fd8 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).reader(0x159e3c8, {0x8874d0, 0xd0ad00}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1459c28 sp=0x1459b9c pc=0x47b1ec Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).Reader(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).Read(0x159e3c8, {0x8874d0, 0xd0ad00}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1459c50 sp=0x1459c28 pc=0x4798bc Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x1459ccc sp=0x1459c50 pc=0x633988 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.HandlerFunc.ServeHTTP(0x162a180, {0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1459cdc sp=0x1459ccc pc=0x33d7f4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*ServeMux).ServeHTTP(0x1620000, {0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1459d18 sp=0x1459cdc pc=0x33f654 Apr 15 18:18:26 125volumio go-librespot[2098]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1459d40 sp=0x1459d18 pc=0x633388 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.HandlerFunc.ServeHTTP(0x1624160, {0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1459d50 sp=0x1459d40 pc=0x33d7f4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.serverHandler.ServeHTTP({0x162c0a8}, {0x886dec, 0x153a508}, 0x162dea8) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1459d6c sp=0x1459d50 pc=0x340de4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*conn).serve(0x1429500, {0x887510, 0x1636180}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1459fdc sp=0x1459d6c pc=0x33c034 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*Server).Serve.gowrap3() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1459fec sp=0x1459fdc pc=0x341688 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1459fec sp=0x1459fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by net/http.(*Server).Serve in goroutine 20 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/server.go:3285 +0x468 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 71 gp=0x1584c68 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091b48, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16efad4 sp=0x16efac0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091b38, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x16efaec sp=0x16efad4 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091b38, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x16efb00 sp=0x16efaec pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x1664f18, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x16efb14 sp=0x16efb00 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x1664f00, {0x166c000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x16efb5c sp=0x16efb14 pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x1664f00, {0x166c000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x16efb88 sp=0x16efb5c pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x15be3e8, {0x166c000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x16efbb4 sp=0x16efb88 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x15be3e8, {0x166c000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x16efbd4 sp=0x16efbb4 pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*atLeastReader).Read(0x16ae260, {0x166c000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x16efc00 sp=0x16efbd4 pc=0x27c680 Apr 15 18:18:26 125volumio go-librespot[2098]: bytes.(*Buffer).ReadFrom(0x1784a8c, {0x883674, 0x16ae260}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x16efc3c sp=0x16efc00 pc=0x139bd0 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readFromUntil(0x1784908, {0x882848, 0x15be3e8}, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x16efc64 sp=0x16efc3c pc=0x27c8dc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecordOrCCS(0x1784908, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x16efdc8 sp=0x16efc64 pc=0x279fdc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).Read(0x1784908, {0x167a000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x16efdf8 sp=0x16efdc8 pc=0x27fe4c Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).Read(0x166a8a0, {0x159c2a4, 0x9, 0x9}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x16efe1c sp=0x16efdf8 pc=0x2be440 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadAtLeast({0x882a3c, 0x166a8a0}, {0x159c2a4, 0x9, 0x9}, 0x9) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x16efe48 sp=0x16efe1c pc=0x1042c0 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadFull(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.http2readFrameHeader({0x159c2a4, 0x9, 0x9}, {0x882a3c, 0x166a8a0}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x16efe70 sp=0x16efe48 pc=0x2f733c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Framer).ReadFrame(0x159c280) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x16efeec sp=0x16efe70 pc=0x2f7ad4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2clientConnReadLoop).run(0x16effdc) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x16effa4 sp=0x16efeec pc=0x31c2f0 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2ClientConn).readLoop(0x14bfe08) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x16effe4 sp=0x16effa4 pc=0x31b7e4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x16effec sp=0x16effe4 pc=0x314830 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16effec sp=0x16effec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by net/http.(*http2Transport).newClientConn in goroutine 70 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 75 gp=0x1896a28 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091968, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16f3ad4 sp=0x16f3ac0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091958, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x16f3aec sp=0x16f3ad4 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091958, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x16f3b00 sp=0x16f3aec pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x18b8018, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x16f3b14 sp=0x16f3b00 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x18b8000, {0x1801000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x16f3b5c sp=0x16f3b14 pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x18b8000, {0x1801000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x16f3b88 sp=0x16f3b5c pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x15beee8, {0x1801000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x16f3bb4 sp=0x16f3b88 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x15beee8, {0x1801000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x16f3bd4 sp=0x16f3bb4 pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*atLeastReader).Read(0x1777190, {0x1801000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x16f3c00 sp=0x16f3bd4 pc=0x27c680 Apr 15 18:18:26 125volumio go-librespot[2098]: bytes.(*Buffer).ReadFrom(0x1784ccc, {0x883674, 0x1777190}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x16f3c3c sp=0x16f3c00 pc=0x139bd0 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readFromUntil(0x1784b48, {0x882848, 0x15beee8}, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x16f3c64 sp=0x16f3c3c pc=0x27c8dc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecordOrCCS(0x1784b48, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x16f3dc8 sp=0x16f3c64 pc=0x279fdc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).Read(0x1784b48, {0x1821000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x16f3df8 sp=0x16f3dc8 pc=0x27fe4c Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).Read(0x181a600, {0x159c3a4, 0x9, 0x9}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x16f3e1c sp=0x16f3df8 pc=0x2be440 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadAtLeast({0x882a3c, 0x181a600}, {0x159c3a4, 0x9, 0x9}, 0x9) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x16f3e48 sp=0x16f3e1c pc=0x1042c0 Apr 15 18:18:26 125volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadFull(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.http2readFrameHeader({0x159c3a4, 0x9, 0x9}, {0x882a3c, 0x181a600}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x16f3e70 sp=0x16f3e48 pc=0x2f733c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Framer).ReadFrame(0x159c380) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x16f3eec sp=0x16f3e70 pc=0x2f7ad4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2clientConnReadLoop).run(0x16f3fdc) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x16f3fa4 sp=0x16f3eec pc=0x31c2f0 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2ClientConn).readLoop(0x14bff08) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x16f3fe4 sp=0x16f3fa4 pc=0x31b7e4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x16f3fec sp=0x16f3fe4 pc=0x314830 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16f3fec sp=0x16f3fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by net/http.(*http2Transport).newClientConn in goroutine 74 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 41 gp=0x1896b48 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18b7674 sp=0x18b7660 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x18b7774, 0x18b773c, 0x0, 0x0, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x18b7714 sp=0x18b7674 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x18b8cd0) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/player/player.go:201 +0x1fc fp=0x18b77e4 sp=0x18b7714 pc=0x513660 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/player/player.go:183 +0x28 fp=0x18b77ec sp=0x18b77e4 pc=0x513240 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18b77ec sp=0x18b77ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/player/player.go:183 +0x218 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 64 gp=0x16478c8 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14426a8 sp=0x1442694 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x14427a4, 0x144276c, 0x0, 0x0, 0x5, 0x1) Apr 15 18:18:26 125volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1442748 sp=0x14426a8 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x159e648) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x14427e4 sp=0x1442748 pc=0x474738 Apr 15 18:18:26 125volumio go-librespot[2098]: nhooyr.io/websocket.newConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x14427ec sp=0x14427e4 pc=0x47432c Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14427ec sp=0x14427ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by nhooyr.io/websocket.newConn in goroutine 42 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 65 gp=0x16479e8 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091a08, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x17fed14 sp=0x17fed00 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb60919f8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x17fed2c sp=0x17fed14 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb60919f8, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x17fed40 sp=0x17fed2c pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x173aec8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x17fed54 sp=0x17fed40 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x173aeb0, {0x19026e0, 0x3, 0x3}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x17fed9c sp=0x17fed54 pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x173aeb0, {0x19026e0, 0x3, 0x3}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x17fedc8 sp=0x17fed9c pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x1431918, {0x19026e0, 0x3, 0x3}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x17fedf4 sp=0x17fedc8 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x1431918, {0x19026e0, 0x3, 0x3}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x17fee14 sp=0x17fedf4 pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadAtLeast({0x882848, 0x1431918}, {0x19026e0, 0x3, 0x3}, 0x3) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x17fee40 sp=0x17fee14 pc=0x1042c0 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadFull(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x15c74c0, {0x8874f0, 0xd0ad00}) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/shannon.go:124 +0x3a0 fp=0x17fef04 sp=0x17fee40 pc=0x48faf4 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x187a0b8) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:276 +0x68 fp=0x17fefe4 sp=0x17fef04 pc=0x48c330 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:260 +0x28 fp=0x17fefec sp=0x17fefe4 pc=0x48c29c Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x17fefec sp=0x17fefec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 42 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:260 +0x98 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 82 gp=0x1647b08 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14406b8 sp=0x14406a4 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x14407d4, 0x144077c, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1440758 sp=0x14406b8 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x187a0b8) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:355 +0x8c fp=0x14407e4 sp=0x1440758 pc=0x48cb50 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:264 +0x28 fp=0x14407ec sp=0x14407e4 pc=0x48c248 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14407ec sp=0x14407ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 42 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/ap/ap.go:264 +0x15c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 83 gp=0x1647d48 m=nil [chan receive]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e3f90, 0x1900930, 0xe, 0x7, 0x2) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1435d60 sp=0x1435d4c pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv(0x1900900, 0x1435ddb, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1435d9c sp=0x1435d60 pc=0x20078 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.chanrecv1(0x1900900, 0x1435ddb) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x1435db0 sp=0x1435d9c pc=0x1fb98 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x16ca218, 0x1664e10) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/recv.go:237 +0x1f8 fp=0x1435f2c sp=0x1435db0 pc=0x533ab4 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x16ca218) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:213 +0x4d8 fp=0x1435fe4 sp=0x1435f2c pc=0x5321e4 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:125 +0x28 fp=0x1435fec sp=0x1435fe4 pc=0x53383c Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1435fec sp=0x1435fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 42 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:125 +0x98 Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 84 gp=0x1647e68 m=nil [select]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x164f698 sp=0x164f684 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.selectgo(0x164f7d4, 0x164f760, 0x0, 0x0, 0x2, 0x1) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x164f738 sp=0x164f698 pc=0x70e78 Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x16ca218) Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:138 +0x8c fp=0x164f7e4 sp=0x164f738 pc=0x5318dc Apr 15 18:18:26 125volumio go-librespot[2098]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:129 +0x28 fp=0x164f7ec sp=0x164f7e4 pc=0x5337e8 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x164f7ec sp=0x164f7ec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 42 Apr 15 18:18:26 125volumio go-librespot[2098]: /src/dealer/dealer.go:129 +0x15c Apr 15 18:18:26 125volumio go-librespot[2098]: goroutine 114 gp=0x1916b48 m=nil [IO wait]: Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.gopark(0x7e40f0, 0xb6091be8, 0x2, 0x2, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1456ad4 sp=0x1456ac0 pc=0x5d0c0 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.netpollblock(0xb6091bd8, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1456aec sp=0x1456ad4 pc=0x548cc Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.runtime_pollWait(0xb6091bd8, 0x72) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1456b00 sp=0x1456aec pc=0x8f4a8 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).wait(0x147f508, 0x72, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1456b14 sp=0x1456b00 pc=0x10a318 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*pollDesc).waitRead(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 15 18:18:26 125volumio go-librespot[2098]: internal/poll.(*FD).Read(0x147f4f0, {0x18e5000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1456b5c sp=0x1456b14 pc=0x10b504 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*netFD).Read(0x147f4f0, {0x18e5000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1456b88 sp=0x1456b5c pc=0x17c5d0 Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*conn).Read(0x16aa000, {0x18e5000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1456bb4 sp=0x1456b88 pc=0x18caec Apr 15 18:18:26 125volumio go-librespot[2098]: net.(*TCPConn).Read(0x16aa000, {0x18e5000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: :1 +0x44 fp=0x1456bd4 sp=0x1456bb4 pc=0x19fd40 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*atLeastReader).Read(0x1777940, {0x18e5000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1456c00 sp=0x1456bd4 pc=0x27c680 Apr 15 18:18:26 125volumio go-librespot[2098]: bytes.(*Buffer).ReadFrom(0x189ef0c, {0x883674, 0x1777940}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1456c3c sp=0x1456c00 pc=0x139bd0 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readFromUntil(0x189ed88, {0x882848, 0x16aa000}, 0x5) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1456c64 sp=0x1456c3c pc=0x27c8dc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecordOrCCS(0x189ed88, 0x0) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1456dc8 sp=0x1456c64 pc=0x279fdc Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).readRecord(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:588 Apr 15 18:18:26 125volumio go-librespot[2098]: crypto/tls.(*Conn).Read(0x189ed88, {0x18ba000, 0x1000, 0x1000}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1456df8 sp=0x1456dc8 pc=0x27fe4c Apr 15 18:18:26 125volumio go-librespot[2098]: bufio.(*Reader).Read(0x191b350, {0x149aa24, 0x9, 0x9}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1456e1c sp=0x1456df8 pc=0x2be440 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadAtLeast({0x882a3c, 0x191b350}, {0x149aa24, 0x9, 0x9}, 0x9) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1456e48 sp=0x1456e1c pc=0x1042c0 Apr 15 18:18:26 125volumio go-librespot[2098]: io.ReadFull(...) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/io/io.go:354 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.http2readFrameHeader({0x149aa24, 0x9, 0x9}, {0x882a3c, 0x191b350}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1456e70 sp=0x1456e48 pc=0x2f733c Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Framer).ReadFrame(0x149aa00) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1456eec sp=0x1456e70 pc=0x2f7ad4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2clientConnReadLoop).run(0x1456fdc) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1456fa4 sp=0x1456eec pc=0x31c2f0 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2ClientConn).readLoop(0x1748108) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1456fe4 sp=0x1456fa4 pc=0x31b7e4 Apr 15 18:18:26 125volumio go-librespot[2098]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1456fec sp=0x1456fe4 pc=0x314830 Apr 15 18:18:26 125volumio go-librespot[2098]: runtime.goexit({}) Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1456fec sp=0x1456fec pc=0x93d6c Apr 15 18:18:26 125volumio go-librespot[2098]: created by net/http.(*http2Transport).newClientConn in goroutine 49 Apr 15 18:18:26 125volumio go-librespot[2098]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Apr 15 18:18:26 125volumio go-librespot[2097]: Aborted Apr 15 18:18:26 125volumio volumio[1150]: info: Connection to go-librespot Websocket closed Apr 15 18:18:27 125volumio volumio[1150]: info: Getting Spotify volume Apr 15 18:18:27 125volumio volumio[1150]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 18:18:27 125volumio volumio[1150]: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 15 18:18:27 125volumio volumio[1150]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 15 18:18:27 125volumio volumio[1150]: errno: -111, Apr 15 18:18:27 125volumio volumio[1150]: code: 'ECONNREFUSED', Apr 15 18:18:27 125volumio volumio[1150]: syscall: 'connect', Apr 15 18:18:27 125volumio volumio[1150]: address: '127.0.0.1', Apr 15 18:18:27 125volumio volumio[1150]: port: 9879, Apr 15 18:18:27 125volumio volumio[1150]: response: undefined Apr 15 18:18:27 125volumio volumio[1150]: } Apr 15 18:18:27 125volumio volumio[1150]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 15 18:18:29 125volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Apr 15 18:18:29 125volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 15 18:18:29 125volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 15 18:18:29 125volumio go-librespot[2132]: go-librespot daemon starting... Apr 15 18:18:29 125volumio go-librespot[2134]: time="2026-04-15T18:18:29+09:00" level=info msg="running go-librespot 0.4.0" Apr 15 18:18:29 125volumio go-librespot[2134]: time="2026-04-15T18:18:29+09:00" level=debug msg="app state loaded" Apr 15 18:18:29 125volumio go-librespot[2134]: time="2026-04-15T18:18:29+09:00" level=debug msg="stored credentials not found" Apr 15 18:18:29 125volumio go-librespot[2134]: time="2026-04-15T18:18:29+09:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 15 18:18:30 125volumio go-librespot[2134]: time="2026-04-15T18:18:30+09:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]" Apr 15 18:18:30 125volumio go-librespot[2134]: time="2026-04-15T18:18:30+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Apr 15 18:18:30 125volumio go-librespot[2134]: time="2026-04-15T18:18:30+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]" Apr 15 18:18:30 125volumio go-librespot[2134]: time="2026-04-15T18:18:30+09:00" level=info msg="zeroconf server listening on port 43029" Apr 15 18:18:30 125volumio sudo[2143]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-15 18:17' Apr 15 18:18:30 125volumio sudo[2143]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"