-- Logs begin at Thu 2025-05-01 17:00:31 CEST, end at Sun 2025-05-04 20:24:33 CEST. -- May 04 20:23:05 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:05+02:00" level=debug msg="renewing login5 access token" May 04 20:23:07 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:07+02:00" level=error msg="did not receive last pong from dealer, 870s passed" May 04 20:23:11 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:11+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew4.spotify.com: i/o timeout" May 04 20:23:29 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:29+02:00" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": dial tcp: lookup apresolve.spotify.com: device or resource busy" May 04 20:23:37 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:37+02:00" level=error msg="did not receive last pong from dealer, 900s passed" May 04 20:23:41 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:41+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew4.spotify.com: i/o timeout" May 04 20:23:59 minidsp-shd go-librespot[18605]: time="2025-05-04T20:23:59+02:00" level=warning msg="failed fetching new endpoint for accesspoint" error="failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint\": dial tcp: lookup apresolve.spotify.com: device or resource busy" May 04 20:24:02 minidsp-shd go-librespot[18605]: time="2025-05-04T20:24:02+02:00" level=debug msg="renewing login5 access token" May 04 20:24:07 minidsp-shd go-librespot[18605]: time="2025-05-04T20:24:07+02:00" level=error msg="did not receive last pong from dealer, 930s passed" May 04 20:24:07 minidsp-shd go-librespot[18605]: time="2025-05-04T20:24:07+02:00" level=error msg="did not receive last pong ack from accesspoint, 960s passed" May 04 20:24:20 minidsp-shd go-librespot[18605]: time="2025-05-04T20:24:20+02:00" level=error msg="failed reconnecting dealer" error="failed obtaining dealer access token: failed renewing login5 access token: failed requesting login5 endpoint: failed requesting login5: Post \"https://login5.spotify.com/v3/login\": dial tcp: lookup login5.spotify.com: device or resource busy" May 04 20:24:20 minidsp-shd go-librespot[18605]: fatal error: sync: Unlock of unlocked RWMutex May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 76 gp=0x25a37a8 m=3 mp=0x244ab08 [running]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.fatal({0x7166ea, 0x20}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/panic.go:1042 +0x4c fp=0x2686f08 sp=0x2686ef4 pc=0x56928 May 04 20:24:20 minidsp-shd go-librespot[18605]: sync.fatal({0x7166ea, 0x20}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/panic.go:1007 +0x24 fp=0x2686f14 sp=0x2686f08 pc=0x8d02c May 04 20:24:20 minidsp-shd go-librespot[18605]: sync.(*RWMutex).Unlock(0x2786314) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/sync/rwmutex.go:208 +0x50 fp=0x2686f2c sp=0x2686f14 pc=0x9dfe0 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x27862c8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/dealer/dealer.go:244 +0x758 fp=0x2686fe4 sp=0x2686f2c pc=0x4e6454 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/dealer/dealer.go:125 +0x28 fp=0x2686fec sp=0x2686fe4 pc=0x4e7828 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2686fec sp=0x2686fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 83 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/dealer/dealer.go:125 +0x98 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 1 gp=0x2402128 m=nil [select, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x26c4cfc sp=0x26c4ce8 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x26c4dfc, 0x2555dc8, 0x0, 0x0, 0x2, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x26c4d9c sp=0x26c4cfc pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x269c000, 0x26c4e88) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/zeroconf/zeroconf.go:270 +0x228 fp=0x26c4e40 sp=0x26c4d9c pc=0x55af74 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).withAppPlayer(0x2495b40, {0x7d1e9c, 0xbefff8}, 0x24ab360) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:316 +0x514 fp=0x26c4ec8 sp=0x26c4e40 pc=0x5f000c May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).withCredentials(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:190 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).SpotifyToken(0x2495b40, {0x7d1e9c, 0xbefff8}, {0x24acf38, 0x8}, {0x255c120, 0x110}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:182 +0xd8 fp=0x26c4ef8 sp=0x26c4ec8 pc=0x5ef500 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.main() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:618 +0x61c fp=0x26c4fa8 sp=0x26c4ef8 pc=0x5f2c98 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.main() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x26c4fec sp=0x26c4fa8 pc=0x59c78 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x26c4fec sp=0x26c4fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 2 gp=0x24027e8 m=nil [force gc (idle), 3 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310cc, 0xbc4928, 0x11, 0xa, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2446fd4 sp=0x2446fc0 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goparkunlock(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:408 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.forcegchelper() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x2446fec sp=0x2446fd4 pc=0x5a044 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2446fec sp=0x2446fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.init.5 in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:314 +0x1c May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 18 gp=0x2484248 m=nil [GC sweep wait]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310cc, 0xbc4ee0, 0xc, 0x9, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x24427c4 sp=0x24427b0 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goparkunlock(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:408 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.bgsweep(0x246e000) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x24427e4 sp=0x24427c4 pc=0x42990 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcenable.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x24427ec sp=0x24427e4 pc=0x32ab0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x24427ec sp=0x24427ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcenable in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:203 +0x74 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 19 gp=0x2484368 m=nil [GC scavenge wait]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310cc, 0xbc5508, 0xd, 0xa, 0x2) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2442fb4 sp=0x2442fa0 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goparkunlock(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:408 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.(*scavengerState).park(0xbc5508) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2442fc8 sp=0x2442fb4 pc=0x3fcb0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.bgscavenge(0x246e000) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x2442fe4 sp=0x2442fc8 pc=0x403e8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcenable.gowrap2() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x2442fec sp=0x2442fe4 pc=0x32a5c May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2442fec sp=0x2442fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcenable in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:204 +0xbc May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 20 gp=0x24846c8 m=nil [finalizer wait, 1384 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f78, 0xbf0094, 0x10, 0xa, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x244378c sp=0x2443778 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.runfinq() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x24437ec sp=0x244378c pc=0x3189c May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x24437ec sp=0x24437ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.createfing in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 23 gp=0x2485c28 m=nil [IO wait, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310bc, 0xf6e7ff08, 0x2, 0x2, 0x5) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2443d28 sp=0x2443d14 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.netpollblock(0xf6e7fef8, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2443d40 sp=0x2443d28 pc=0x51a14 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.runtime_pollWait(0xf6e7fef8, 0x72) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2443d54 sp=0x2443d40 pc=0x8c5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).wait(0x24a71e8, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2443d68 sp=0x2443d54 pc=0x107518 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).waitRead(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*FD).Accept(0x24a71d0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x2443db0 sp=0x2443d68 pc=0x10bd84 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*netFD).accept(0x24a71d0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x2443e18 sp=0x2443db0 pc=0x17b56c May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*TCPListener).accept(0x24b0810) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2443e30 sp=0x2443e18 pc=0x19366c May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*TCPListener).Accept(0x24b0810) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x2443e4c sp=0x2443e30 pc=0x1926d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*onceCloseListener).Accept(0x2614340) May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x34 fp=0x2443e64 sp=0x2443e4c pc=0x35f8c0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Server).Serve(0x260c0a8, {0x7d1680, 0x24b0810}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x2443efc sp=0x2443e64 pc=0x33df7c May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.Serve(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2794 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*ConcreteApiServer).serve(0x24dafc0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/api_server.go:610 +0x974 fp=0x2443fe4 sp=0x2443efc pc=0x5e5e00 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.NewApiServer.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/api_server.go:289 +0x28 fp=0x2443fec sp=0x2443fe4 pc=0x5e4cd0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2443fec sp=0x2443fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by main.NewApiServer in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/api_server.go:289 +0x310 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 6 gp=0x2485d48 m=nil [IO wait]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310bc, 0xf6e7fd28, 0x2, 0x2, 0x5) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2680e84 sp=0x2680e70 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.netpollblock(0xf6e7fd18, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2680e9c sp=0x2680e84 pc=0x51a14 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.runtime_pollWait(0xf6e7fd18, 0x72) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2680eb0 sp=0x2680e9c pc=0x8c5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).wait(0x2690108, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2680ec4 sp=0x2680eb0 pc=0x107518 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).waitRead(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*FD).RawRead(0x26900f0, 0x2497a40) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x2680ef0 sp=0x2680ec4 pc=0x10c988 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*rawConn).Read(0x24903f0, 0x2497a40) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x2680f10 sp=0x2680ef0 pc=0x18da94 May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x2758240, 0x2497a10, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x2680f40 sp=0x2680f10 pc=0x4fb96c May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x261e098, {0x2776000, 0x10000, 0x10000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x2680f9c sp=0x2680f40 pc=0x4ff954 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/grandcat/zeroconf.(*Server).recv4(0x25a06c0, 0x261e090) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x2680fe0 sp=0x2680f9c pc=0x5561e4 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x2680fec sp=0x2680fe0 pc=0x555e9c May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2680fec sp=0x2680fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 27 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 54 gp=0x2485e68 m=nil [IO wait, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310bc, 0xf6e7f8c8, 0x2, 0x2, 0x5) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x268387c sp=0x2683868 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.netpollblock(0xf6e7f8b8, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2683894 sp=0x268387c pc=0x51a14 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.runtime_pollWait(0xf6e7f8b8, 0x72) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x26838a8 sp=0x2683894 pc=0x8c5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).wait(0x259a158, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x26838bc sp=0x26838a8 pc=0x107518 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).waitRead(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*FD).Read(0x259a140, {0x26e6000, 0x1000, 0x1000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2683904 sp=0x26838bc pc=0x108704 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*netFD).Read(0x259a140, {0x26e6000, 0x1000, 0x1000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2683930 sp=0x2683904 pc=0x179678 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*conn).Read(0x260a2f0, {0x26e6000, 0x1000, 0x1000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x268395c sp=0x2683930 pc=0x189858 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*TCPConn).Read(0x260a2f0, {0x26e6000, 0x1000, 0x1000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x44 fp=0x268397c sp=0x268395c pc=0x19caac May 04 20:24:20 minidsp-shd go-librespot[18605]: io.(*multiReader).Read(0x25ee070, {0x26e6000, 0x1000, 0x1000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x26839a8 sp=0x268397c pc=0x102728 May 04 20:24:20 minidsp-shd go-librespot[18605]: bufio.(*Reader).fill(0x25d6030) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x26839cc sp=0x26839a8 pc=0x2bab20 May 04 20:24:20 minidsp-shd go-librespot[18605]: bufio.(*Reader).ReadByte(0x25d6030) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x26839d8 sp=0x26839cc pc=0x2bb3a4 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.readFrameHeader(0x25d6030, {0x25427b8, 0x8, 0x8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x2683a18 sp=0x26839d8 pc=0x46db90 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x2542788, {0x7d1e7c, 0xbefff8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x2683ad8 sp=0x2683a18 pc=0x4707f4 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).readLoop(0x2542788, {0x7d1e7c, 0xbefff8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x2683b9c sp=0x2683ad8 pc=0x4702dc May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).reader(0x2542788, {0x7d1e7c, 0xbefff8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x2683c28 sp=0x2683b9c pc=0x4714f0 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).Reader(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).Read(0x2542788, {0x7d1e7c, 0xbefff8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x2683c50 sp=0x2683c28 pc=0x46fbc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*ConcreteApiServer).serve.func17({0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/api_server.go:580 +0x3c0 fp=0x2683ccc sp=0x2683c50 pc=0x5e66d0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.HandlerFunc.ServeHTTP(0x260a180, {0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2683cdc sp=0x2683ccc pc=0x33a560 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*ServeMux).ServeHTTP(0x2600000, {0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x2683d18 sp=0x2683cdc pc=0x33c3c0 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x2683d40 sp=0x2683d18 pc=0x5e60d0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.HandlerFunc.ServeHTTP(0x2604160, {0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2683d50 sp=0x2683d40 pc=0x33a560 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.serverHandler.ServeHTTP({0x260c0a8}, {0x7d17b4, 0x260c288}, 0x260c1e8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x2683d6c sp=0x2683d50 pc=0x33db50 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*conn).serve(0x269c1e0, {0x7d1ebc, 0x2616180}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x2683fdc sp=0x2683d6c pc=0x338da0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Server).Serve.gowrap3() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x2683fec sp=0x2683fdc pc=0x33e3f4 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2683fec sp=0x2683fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by net/http.(*Server).Serve in goroutine 23 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:3285 +0x468 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 37 gp=0x25a2008 m=nil [GC worker (idle), 447 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f88, 0x262e6f0, 0x1a, 0xa, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2446790 sp=0x244677c pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcBgMarkWorker() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x24467ec sp=0x2446790 pc=0x356d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x24467ec sp=0x24467ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcBgMarkStartWorkers in goroutine 36 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 3 gp=0x2402d88 m=nil [GC worker (idle), 3 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f88, 0x242b590, 0x1a, 0xa, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2447790 sp=0x244777c pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcBgMarkWorker() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x24477ec sp=0x2447790 pc=0x356d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x24477ec sp=0x24477ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcBgMarkStartWorkers in goroutine 36 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 4 gp=0x2402ea8 m=nil [GC worker (idle), 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f88, 0x242b5a8, 0x1a, 0xa, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2447f90 sp=0x2447f7c pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcBgMarkWorker() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x2447fec sp=0x2447f90 pc=0x356d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2447fec sp=0x2447fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcBgMarkStartWorkers in goroutine 36 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 5 gp=0x2402fc8 m=nil [GC worker (idle)]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f88, 0x242b5c0, 0x1a, 0xa, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2448790 sp=0x244877c pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gcBgMarkWorker() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x24487ec sp=0x2448790 pc=0x356d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x24487ec sp=0x24487ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by runtime.gcBgMarkStartWorkers in goroutine 36 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 7 gp=0x2632128 m=nil [IO wait, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310bc, 0xf6e7fc88, 0x2, 0x2, 0x5) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2707e5c sp=0x2707e48 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.netpollblock(0xf6e7fc78, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2707e74 sp=0x2707e5c pc=0x51a14 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.runtime_pollWait(0xf6e7fc78, 0x72) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2707e88 sp=0x2707e74 pc=0x8c5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).wait(0x2690158, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2707e9c sp=0x2707e88 pc=0x107518 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).waitRead(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*FD).RawRead(0x2690140, 0x26b7dd0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x2707ec8 sp=0x2707e9c pc=0x10c988 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*rawConn).Read(0x2490418, 0x26b7dd0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x2707ee8 sp=0x2707ec8 pc=0x18da94 May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x2758250, 0x26b7da0, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x2707f18 sp=0x2707ee8 pc=0x4fb96c May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 May 04 20:24:20 minidsp-shd go-librespot[18605]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x261e0c8, {0x2766000, 0x10000, 0x10000}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x2707f9c sp=0x2707f18 pc=0x5032dc May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/grandcat/zeroconf.(*Server).recv6(0x25a06c0, 0x261e0c0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x2707fe0 sp=0x2707f9c pc=0x5563d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x2707fec sp=0x2707fe0 pc=0x555e40 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2707fec sp=0x2707fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 27 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 81 gp=0x25a3208 m=nil [select, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2572ea8 sp=0x2572e94 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2572fa4, 0x2572f6c, 0x0, 0x0, 0x5, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2572f48 sp=0x2572ea8 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x2542788) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x2572fe4 sp=0x2572f48 pc=0x46aa3c May 04 20:24:20 minidsp-shd go-librespot[18605]: nhooyr.io/websocket.newConn.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x2572fec sp=0x2572fe4 pc=0x46a630 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2572fec sp=0x2572fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by nhooyr.io/websocket.newConn in goroutine 54 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 82 gp=0x27f0908 m=nil [select, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2703e74 sp=0x2703e60 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2703f74, 0x2703f3c, 0x0, 0x0, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2703f14 sp=0x2703e74 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x27dd740) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/player/player.go:181 +0x1fc fp=0x2703fe4 sp=0x2703f14 pc=0x4c8e18 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/player/player.go:163 +0x28 fp=0x2703fec sp=0x2703fe4 pc=0x4c89f8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2703fec sp=0x2703fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/player/player.go:163 +0x1c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 83 gp=0x27f0b48 m=nil [select, 306 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2553854 sp=0x2553840 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2553e10, 0x2553a34, 0x0, 0x0, 0x8, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x25538f4 sp=0x2553854 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*AppPlayer).Run(0x2690190, {0x7d1e9c, 0xbefff8}, 0x2741100) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/player.go:570 +0x370 fp=0x2553fd8 sp=0x25538f4 pc=0x5f8160 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).withAppPlayer.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:254 +0x40 fp=0x2553fec sp=0x2553fd8 pc=0x5f0c84 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2553fec sp=0x2553fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by main.(*App).withAppPlayer in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:254 +0x398 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 84 gp=0x27f0c68 m=nil [chan receive, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f5c, 0x2498270, 0xe, 0x7, 0x2) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2704f48 sp=0x2704f34 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.chanrecv(0x2498240, 0x2704fd0, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x2704f84 sp=0x2704f48 pc=0x1d1c0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.chanrecv2(0x2498240, 0x2704fd0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x2704f98 sp=0x2704f84 pc=0x1cd04 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).withAppPlayer.func1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:264 +0x68 fp=0x2704fec sp=0x2704f98 pc=0x5f0ba4 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2704fec sp=0x2704fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by main.(*App).withAppPlayer in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:261 +0x424 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 85 gp=0x27f0d88 m=nil [chan receive, 1386 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x730f5c, 0x2498230, 0xe, 0x7, 0x2) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2705738 sp=0x2705724 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.chanrecv(0x2498200, 0x27057e0, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x2705774 sp=0x2705738 pc=0x1d1c0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.chanrecv2(0x2498200, 0x27057e0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x2705788 sp=0x2705774 pc=0x1cd04 May 04 20:24:20 minidsp-shd go-librespot[18605]: main.(*App).withAppPlayer.func2() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:280 +0x6c fp=0x27057ec sp=0x2705788 pc=0x5f076c May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x27057ec sp=0x27057ec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by main.(*App).withAppPlayer in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/cmd/daemon/main.go:277 +0x4c4 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 86 gp=0x27f0ea8 m=nil [IO wait, 370 minutes]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x7310bc, 0xf6e7fdc8, 0x2, 0x2, 0x5) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2705de8 sp=0x2705dd4 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.netpollblock(0xf6e7fdb8, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2705e00 sp=0x2705de8 pc=0x51a14 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.runtime_pollWait(0xf6e7fdb8, 0x72) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2705e14 sp=0x2705e00 pc=0x8c5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).wait(0x26900b8, 0x72, 0x0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2705e28 sp=0x2705e14 pc=0x107518 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*pollDesc).waitRead(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/poll.(*FD).Accept(0x26900a0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x2705e70 sp=0x2705e28 pc=0x10bd84 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*netFD).accept(0x26900a0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x2705ed8 sp=0x2705e70 pc=0x17b56c May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*TCPListener).accept(0x26920a8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2705ef0 sp=0x2705ed8 pc=0x19366c May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*TCPListener).Accept(0x26920a8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x2705f0c sp=0x2705ef0 pc=0x1926d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*onceCloseListener).Accept(0x27df060) May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x34 fp=0x2705f24 sp=0x2705f0c pc=0x35f8c0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Server).Serve(0x2563868, {0x7d1680, 0x26920a8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x2705fbc sp=0x2705f24 pc=0x33df7c May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.Serve(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/server.go:2794 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/zeroconf/zeroconf.go:267 +0x8c fp=0x2705fec sp=0x2705fbc pc=0x55b070 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2705fec sp=0x2705fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/zeroconf/zeroconf.go:267 +0x160 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 74 gp=0x25a3568 m=nil [select]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x24594c8 sp=0x24594b4 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2459600, 0x24595a8, 0x0, 0x0, 0x4, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2459568 sp=0x24594c8 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).getConn(0xb7e118, 0x25f5420, {{}, 0x0, {0x714de0, 0x5}, {0x26966e0, 0x19}, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1406 +0x4a0 fp=0x2459698 sp=0x2459568 pc=0x34e3e4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).roundTrip(0xb7e118, 0x24ae8c8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:595 +0x778 fp=0x24597b4 sp=0x2459698 pc=0x34a3bc May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).RoundTrip(0xb7e118, 0x24ae8c8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/roundtrip.go:17 +0x24 fp=0x24597cc sp=0x24597b4 pc=0x32e7d8 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.send(0x24ae8c8, {0x7ce314, 0xb7e118}, {0x0, 0x0, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/client.go:259 +0x540 fp=0x24598f8 sp=0x24597cc pc=0x2e9500 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Client).send(0x256a2e0, 0x24ae8c8, {0x0, 0x0, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/client.go:180 +0x98 fp=0x245993c sp=0x24598f8 pc=0x2e8df4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Client).do(0x256a2e0, 0x24ae8c8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/client.go:724 +0x8bc fp=0x2459a4c sp=0x245993c pc=0x2eb1f4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Client).Do(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/client.go:590 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).fetchUrls(0x2496450, {0x7d1f1c, 0x259a190}, {0x2459cdc, 0x1, 0x1}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/apresolve/resolve.go:83 +0x4c4 fp=0x2459ca0 sp=0x2459a4c pc=0x4de280 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).get(0x2496450, {0x7d1f1c, 0x259a190}, {0x707891, 0xb}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/apresolve/resolve.go:126 +0x8c fp=0x2459ce8 sp=0x2459ca0 pc=0x4dee28 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).getFunc.func1({0x7d1f1c, 0x259a190}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/apresolve/resolve.go:157 +0x90 fp=0x2459d34 sp=0x2459ce8 pc=0x4df23c May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0x2786168, {0x7d1e9c, 0xbefff8}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:88 +0x220 fp=0x2459db0 sp=0x2459d34 pc=0x4809e8 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0x2786168, {0x7d1e9c, 0xbefff8}, 0x2497920) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:192 +0xd4 fp=0x2459e14 sp=0x2459db0 pc=0x481938 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0x2786168) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:381 +0xcc fp=0x2459e3c sp=0x2459e14 pc=0x482ef4 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x28 fp=0x2459e4c sp=0x2459e3c pc=0x4872d0 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:18 +0x1c fp=0x2459e58 sp=0x2459e4c pc=0x476488 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x2459efc, {0x7d0e08, 0x2590480}, 0x0, {0x0, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:88 +0xe8 fp=0x2459ed4 sp=0x2459e58 pc=0x476958 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x2459f6c, {0x7d0e08, 0x2590480}, 0x0, {0x0, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:61 +0x6c fp=0x2459f04 sp=0x2459ed4 pc=0x476440 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/cenkalti/backoff/v4.RetryNotify(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:49 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/cenkalti/backoff/v4.Retry(...) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:38 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x2786168) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:322 +0x430 fp=0x2459fe4 sp=0x2459f04 pc=0x482790 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:260 +0x28 fp=0x2459fec sp=0x2459fe4 pc=0x482334 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2459fec sp=0x2459fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 83 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:260 +0x98 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 75 gp=0x25a3688 m=nil [select]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2457eb8 sp=0x2457ea4 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2457fd4, 0x2457f7c, 0x0, 0x0, 0x2, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2457f58 sp=0x2457eb8 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x2786168) May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:355 +0x8c fp=0x2457fe4 sp=0x2457f58 pc=0x482be8 May 04 20:24:20 minidsp-shd go-librespot[18605]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:264 +0x28 fp=0x2457fec sp=0x2457fe4 pc=0x4822e0 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2457fec sp=0x2457fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 83 May 04 20:24:20 minidsp-shd go-librespot[18605]: /src/ap/ap.go:264 +0x15c May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 346 gp=0x28e77a8 m=nil [select]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2681b88 sp=0x2681b74 pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x2681c74, 0x2681c4c, 0x0, 0x0, 0x2, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2681c28 sp=0x2681b88 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.doBlockingWithCtx[...]({0x7d1edc, 0x2497950}, 0x2616f48) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:60 +0x134 fp=0x2681c98 sp=0x2681c28 pc=0x19b0ac May 04 20:24:20 minidsp-shd go-librespot[18605]: net.cgoLookupIP({0x7d1edc, 0x2497950}, {0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:216 +0x90 fp=0x2681cc0 sp=0x2681c98 pc=0x16ced0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).lookupIP(0xbc4d30, {0x7d1edc, 0x2497950}, {0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/lookup_unix.go:66 +0x90 fp=0x2681efc sp=0x2681cc0 pc=0x188f68 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).lookupIP-fm({0x7d1edc, 0x2497950}, {0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x58 fp=0x2681f30 sp=0x2681efc pc=0x1a0ce4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.init.func1({0x7d1edc, 0x2497950}, 0x2433120, {0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/hook.go:22 +0x4c fp=0x2681f60 sp=0x2681f30 pc=0x16a230 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).lookupIPAddr.func1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/lookup.go:334 +0x58 fp=0x2681f9c sp=0x2681f60 pc=0x1883e8 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/singleflight.(*Group).doCall(0xbc4d38, 0x2497980, {0x2696700, 0x19}, 0x25f5440) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x1c fp=0x2681fd4 sp=0x2681f9c pc=0x1685e0 May 04 20:24:20 minidsp-shd go-librespot[18605]: internal/singleflight.(*Group).DoChan.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x48 fp=0x2681fec sp=0x2681fd4 pc=0x168598 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2681fec sp=0x2681fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by internal/singleflight.(*Group).DoChan in goroutine 345 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x2fc May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 347 gp=0x25a3b08 m=5 mp=0x2480008 [syscall]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.cgocall(0x5fb48c, 0x2706ec8) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/cgocall.go:157 +0x50 fp=0x2706eb0 sp=0x2706e98 pc=0x1a968 May 04 20:24:20 minidsp-shd go-librespot[18605]: net._C2func_getaddrinfo(0x24bd290, 0x0, 0x25f5460, 0x2433138) May 04 20:24:20 minidsp-shd go-librespot[18605]: _cgo_gotypes.go:101 +0x48 fp=0x2706ec4 sp=0x2706eb0 pc=0x19a0e4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net._C_getaddrinfo.func1(0x24bd290, 0x0, 0x25f5460, 0x2433138) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix_cgo.go:78 +0x7c fp=0x2706ee4 sp=0x2706ec4 pc=0x19a430 May 04 20:24:20 minidsp-shd go-librespot[18605]: net._C_getaddrinfo(0x24bd290, 0x0, 0x25f5460, 0x2433138) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix_cgo.go:78 +0x34 fp=0x2706f04 sp=0x2706ee4 pc=0x19a38c May 04 20:24:20 minidsp-shd go-librespot[18605]: net.cgoLookupHostIP({0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:168 +0x248 fp=0x2706f94 sp=0x2706f04 pc=0x16c8a0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.cgoLookupIP.func1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:217 +0x34 fp=0x2706fbc sp=0x2706f94 pc=0x16cf50 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.doBlockingWithCtx[...].func1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:56 +0x30 fp=0x2706fec sp=0x2706fbc pc=0x19a5c8 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2706fec sp=0x2706fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by net.doBlockingWithCtx[...] in goroutine 346 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/cgo_unix.go:54 +0xb8 May 04 20:24:20 minidsp-shd go-librespot[18605]: goroutine 345 gp=0x2632d88 m=nil [select]: May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.gopark(0x731100, 0x0, 0x9, 0x3, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x26c3860 sp=0x26c384c pc=0x5a208 May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.selectgo(0x26c3a18, 0x26c3930, 0x0, 0x0, 0x2, 0x1) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x26c3900 sp=0x26c3860 pc=0x6dfc0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).lookupIPAddr(0xbc4d30, {0x7d1f1c, 0x259a190}, {0x7042c4, 0x3}, {0x26966e0, 0x15}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/lookup.go:342 +0x394 fp=0x26c3a3c sp=0x26c3900 pc=0x187918 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).internetAddrList(0xbc4d30, {0x7d1f1c, 0x259a190}, {0x7042c4, 0x3}, {0x26966e0, 0x19}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/ipsock.go:288 +0x6bc fp=0x26c3ad0 sp=0x26c3a3c pc=0x185400 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Resolver).resolveAddrList(0xbc4d30, {0x7d1f1c, 0x259a190}, {0x7046a0, 0x4}, {0x7042c4, 0x3}, {0x26966e0, 0x19}, {0x0, ...}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/dial.go:283 +0x510 fp=0x26c3b58 sp=0x26c3ad0 pc=0x16f978 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Dialer).DialContext(0x24a6320, {0x7d1f1c, 0x259a190}, {0x7042c4, 0x3}, {0x26966e0, 0x19}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/dial.go:490 +0x43c fp=0x26c3c40 sp=0x26c3b58 pc=0x1708d0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net.(*Dialer).DialContext-fm({0x7d1f1c, 0x259a190}, {0x7042c4, 0x3}, {0x26966e0, 0x19}) May 04 20:24:20 minidsp-shd go-librespot[18605]: :1 +0x58 fp=0x26c3c70 sp=0x26c3c40 pc=0x360ac4 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).dial(0xb7e118, {0x7d1f1c, 0x259a190}, {0x7042c4, 0x3}, {0x26966e0, 0x19}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1187 +0x158 fp=0x26c3cb0 sp=0x26c3c70 pc=0x34d7e0 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).dialConn(0xb7e118, {0x7d1f1c, 0x259a190}, {{}, 0x0, {0x714de0, 0x5}, {0x26966e0, 0x19}, 0x0}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1648 +0x6bc fp=0x26c3f48 sp=0x26c3cb0 pc=0x3500f8 May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).dialConnFor(0xb7e118, 0x25902a0) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1485 +0x84 fp=0x26c3fe0 sp=0x26c3f48 pc=0x34edfc May 04 20:24:20 minidsp-shd go-librespot[18605]: net/http.(*Transport).queueForDial.gowrap1() May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1449 +0x30 fp=0x26c3fec sp=0x26c3fe0 pc=0x34ed4c May 04 20:24:20 minidsp-shd go-librespot[18605]: runtime.goexit({}) May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x26c3fec sp=0x26c3fec pc=0x90e8c May 04 20:24:20 minidsp-shd go-librespot[18605]: created by net/http.(*Transport).queueForDial in goroutine 74 May 04 20:24:20 minidsp-shd go-librespot[18605]: /usr/local/go/src/net/http/transport.go:1449 +0x98 May 04 20:24:20 minidsp-shd go-librespot[18605]: Aborted May 04 20:24:20 minidsp-shd volumio[30862]: info: Connection to go-librespot Websocket closed May 04 20:24:20 minidsp-shd systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a May 04 20:24:20 minidsp-shd systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. May 04 20:24:23 minidsp-shd volumio[30862]: info: Initializing connection to go-librespot Websocket May 04 20:24:23 minidsp-shd volumio[30862]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 May 04 20:24:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. May 04 20:24:23 minidsp-shd systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 41178. May 04 20:24:23 minidsp-shd systemd[1]: Stopped go-librespot Daemon. May 04 20:24:23 minidsp-shd systemd[1]: Started go-librespot Daemon. May 04 20:24:23 minidsp-shd go-librespot[16880]: go-librespot daemon starting... May 04 20:24:23 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:23+02:00" level=info msg="running go-librespot 0.2.0" May 04 20:24:23 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:23+02:00" level=debug msg="app state loaded" May 04 20:24:23 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:23+02:00" level=info msg="api server listening on 127.0.0.1:9879" May 04 20:24:26 minidsp-shd volumio[30862]: info: Initializing connection to go-librespot Websocket May 04 20:24:26 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:26+02:00" level=debug msg="new websocket client" May 04 20:24:26 minidsp-shd volumio[30862]: info: Connection to go-librespot Websocket established May 04 20:24:29 minidsp-shd volumio[30862]: info: Getting Spotify volume May 04 20:24:29 minidsp-shd volumio[30862]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 May 04 20:24:29 minidsp-shd volumio[30862]: info: CoreCommandRouter::volumioGetState May 04 20:24:29 minidsp-shd volumio[30862]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 May 04 20:24:32 minidsp-shd volumio[30862]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:24:32 minidsp-shd volumio[30862]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { May 04 20:24:32 minidsp-shd volumio[30862]: code: 'auth/network-request-failed', May 04 20:24:32 minidsp-shd volumio[30862]: a: null May 04 20:24:32 minidsp-shd volumio[30862]: } May 04 20:24:32 minidsp-shd volumio[30862]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=info msg="zeroconf server listening on port 40107" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="obtained new client token: AADLdKk+94Z1Kbw39BZXiDEfAwOziAIBAj8e19UHf9wB3HOr/ETcbhe1hsI3WomAJSA6jASTtPLKEXt77Z0oKFwy2DM49dDnWwSLwMJVA1KAOTLd8I82sQ9pC1gjaLhrE/Y0qvLZhyczf66cPlpOSCfF1y32Vh4vbDzbiKWy4GlB2gCmc/1RXvlFAJKARgRwoD9nevORvZl/hYRlr8DslIR4nExuNcmXg3mq8cg+j4qRfJy4REtWK4nus6o=" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="completed keyexchange" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=debug msg="completed challenge" May 04 20:24:32 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:32+02:00" level=info msg="authenticated AP as m89frebo" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=info msg="authenticated Login5 as m89frebo" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="initializing zeroconf session, username: m89frebo" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="dealer connection opened" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=trace msg="starting accesspoint recv loop" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=trace msg="starting dealer recv loop" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=trace msg="received accesspoint ping" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="received connection id: ZmE1YTY0YjktOTk2Ny00ZjEyLTgzMmUtNTMwMDBkZjVmMjg4K2RlYWxlcit0Y3A6Ly8wYWNhNTliNC5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArMDY4MjBCM0RBNTc2RjRFNDBDRUU4QTFGOEI5Qjc4RTVGQkRFMDEwQTc4MDUyNEMzQ0E4NjFFRDhDMkVBNjkwMQ==" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=trace msg="received accesspoint pong ack" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="put connect state because NEW_DEVICE" May 04 20:24:33 minidsp-shd go-librespot[16880]: time="2025-05-04T20:24:33+02:00" level=debug msg="update volume to 65535/65535" May 04 20:24:33 minidsp-shd sudo[16941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-04 20:23 May 04 20:24:33 minidsp-shd sudo[16941]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:00:28 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="29ccfe8a9cff19911db4b736879ac117"