Mar 26 17:36:04 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:17 middle-room go-librespot[1648]: time="2026-03-26T17:36:17Z" level=trace msg="sent dealer ping" Mar 26 17:36:21 middle-room go-librespot[1648]: time="2026-03-26T17:36:21Z" level=trace msg="received dealer pong" Mar 26 17:36:21 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:22 middle-room volumio[1264]: info: Listing playlists Mar 26 17:36:22 middle-room volumio[1264]: info: Listing playlists Mar 26 17:36:23 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:41 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:41 middle-room volumio[1264]: info: Listing playlists Mar 26 17:36:41 middle-room volumio[1264]: info: Listing playlists Mar 26 17:36:43 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:47 middle-room go-librespot[1648]: time="2026-03-26T17:36:47Z" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.0.105:38256->104.199.241.202:80: read: connection reset by peer" Mar 26 17:36:47 middle-room go-librespot[1648]: time="2026-03-26T17:36:47Z" level=error msg="did not receive last pong ack from accesspoint, 155s passed" Mar 26 17:36:47 middle-room go-librespot[1648]: panic: runtime error: invalid memory address or nil pointer dereference Mar 26 17:36:47 middle-room go-librespot[1648]: [signal SIGSEGV: segmentation violation code=0x1 addr=0xc pc=0x4f6f14] Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 99 gp=0x29f2fc8 m=5 mp=0x2900008 [running]: Mar 26 17:36:47 middle-room go-librespot[1648]: panic({0x82e098, 0xf78250}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x2857f20 sp=0x2857ecc pc=0xa92ec Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.panicmem(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/panic.go:262 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.sigpanic() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x2857f50 sp=0x2857f20 pc=0xabca4 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x299fce8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:380 +0x284 fp=0x2857fe4 sp=0x2857f54 pc=0x4f6f14 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:277 +0x28 fp=0x2857fec sp=0x2857fe4 pc=0x4f63e8 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2857fec sp=0x2857fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 73 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:277 +0x15c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 1 gp=0x2802128 m=nil [select, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2c2cce8 sp=0x2c2ccd4 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x2c2cdf8, 0x2a5fdc4, 0x0, 0x0, 0x2, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2c2cd98 sp=0x2c2cce8 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x2924f60, 0x2c2ce90) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/zeroconf/zeroconf.go:283 +0x21c fp=0x2c2ce3c sp=0x2c2cd98 pc=0x61db0c Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).withAppPlayer(0x295c400, {0xa260ac, 0xfdcff0}, 0x2941340) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:340 +0x580 fp=0x2c2ced0 sp=0x2c2ce3c pc=0x6ab088 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).withCredentials(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:209 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).SpotifyToken(0x295c400, {0xa260ac, 0xfdcff0}, {0x2922428, 0x7}, {0x2926280, 0x122}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x2c2cf00 sp=0x2c2ced0 pc=0x6aa4b0 Mar 26 17:36:47 middle-room go-librespot[1648]: main.main() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:593 +0x660 fp=0x2c2cfa8 sp=0x2c2cf00 pc=0x6ad58c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.main() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x2c2cfec sp=0x2c2cfa8 pc=0x6f390 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2c2cfec sp=0x2c2cfec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 2 gp=0x28027e8 m=nil [force gc (idle), 2 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960edc, 0xfd0f08, 0x11, 0xa, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2848fd4 sp=0x2848fc0 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goparkunlock(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:466 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.forcegchelper() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x2848fec sp=0x2848fd4 pc=0x6f7f4 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2848fec sp=0x2848fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.init.6 in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:361 +0x1c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 18 gp=0x2902248 m=nil [GC sweep wait]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960edc, 0xfd17b0, 0xc, 0x9, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28447c4 sp=0x28447b0 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goparkunlock(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:466 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.bgsweep(0x2910000) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x28447e4 sp=0x28447c4 pc=0x5768c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcenable.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x28447ec sp=0x28447e4 pc=0x46c3c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28447ec sp=0x28447ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcenable in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 19 gp=0x2902368 m=nil [GC scavenge wait]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960edc, 0xfd20d0, 0xd, 0xa, 0x2) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2844fb4 sp=0x2844fa0 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goparkunlock(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:466 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.(*scavengerState).park(0xfd20d0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2844fc8 sp=0x2844fb4 pc=0x54a28 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.bgscavenge(0x2910000) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x2844fe4 sp=0x2844fc8 pc=0x5516c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcenable.gowrap2() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x2844fec sp=0x2844fe4 pc=0x46be8 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2844fec sp=0x2844fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcenable in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 20 gp=0x2902488 m=nil [GOMAXPROCS updater (idle), 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960edc, 0xfd1548, 0x12, 0xa, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28457a4 sp=0x2845790 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goparkunlock(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:466 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.updateMaxProcsGoroutine() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x28457ec sp=0x28457a4 pc=0x7f174 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28457ec sp=0x28457ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 34 gp=0x2882248 m=nil [finalizer wait, 4829 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d84, 0xfdd0e0, 0x10, 0xa, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28aa788 sp=0x28aa774 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.runFinalizers() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x28aa7ec sp=0x28aa788 pc=0x45888 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28aa7ec sp=0x28aa7ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.createfing in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 35 gp=0x28825a8 m=nil [cleanup wait, 263 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960edc, 0xfd22a8, 0x2e, 0xa, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28aafa4 sp=0x28aaf90 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goparkunlock(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:466 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.(*cleanupQueue).dequeue(0xfd2248) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x28aafc4 sp=0x28aafa4 pc=0x41cb0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.runCleanups() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x28aafec sp=0x28aafc4 pc=0x4284c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28aafec sp=0x28aafec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 23 gp=0x2a50a28 m=nil [IO wait, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb57c4010, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28464f0 sp=0x28464dc pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb57c4000, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2846508 sp=0x28464f0 pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb57c4000, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x284651c sp=0x2846508 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x29730f8, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2846530 sp=0x284651c pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).Accept(0x29730e0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x2846578 sp=0x2846530 pc=0x1395b0 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*netFD).accept(0x29730e0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x28465e0 sp=0x2846578 pc=0x1aa9d8 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*TCPListener).accept(0x2952420) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2846634 sp=0x28465e0 pc=0x1c2304 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*TCPListener).Accept(0x2952420) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x2846650 sp=0x2846634 pc=0x1c134c Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*onceCloseListener).Accept(0x286f0c0) Mar 26 17:36:47 middle-room go-librespot[1648]: :1 +0x34 fp=0x2846668 sp=0x2846650 pc=0x367710 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Server).Serve(0x299e378, {0xa258a8, 0x2952420}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x2846700 sp=0x2846668 pc=0x3408c8 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.Serve(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2971 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*ConcreteApiServer).serve(0x2924420) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x28467e4 sp=0x2846700 pc=0x69fdac Mar 26 17:36:47 middle-room go-librespot[1648]: main.NewApiServer.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x28467ec sp=0x28467e4 pc=0x69eae4 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28467ec sp=0x28467ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by main.NewApiServer in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/api_server.go:332 +0x310 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 86 gp=0x2a50d88 m=nil [IO wait, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb4d66010, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2d538d4 sp=0x2d538c0 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb4d66000, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2d538ec sp=0x2d538d4 pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb4d66000, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2d53900 sp=0x2d538ec pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x29721f8, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2d53914 sp=0x2d53900 pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).Read(0x29721e0, {0x2984000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2d5395c sp=0x2d53914 pc=0x135f74 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*netFD).Read(0x29721e0, {0x2984000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2d53988 sp=0x2d5395c pc=0x1a8c28 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*conn).Read(0x2912850, {0x2984000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2d539b4 sp=0x2d53988 pc=0x1b842c Mar 26 17:36:47 middle-room go-librespot[1648]: io.(*multiReader).Read(0x2b9cc10, {0x2984000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2d539e0 sp=0x2d539b4 pc=0xef364 Mar 26 17:36:47 middle-room go-librespot[1648]: bufio.(*Reader).fill(0x2a36360) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2d53a04 sp=0x2d539e0 pc=0x2b6390 Mar 26 17:36:47 middle-room go-librespot[1648]: bufio.(*Reader).ReadByte(0x2a36360) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2d53a10 sp=0x2d53a04 pc=0x2b6c0c Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.readFrameHeader(0x2a36360, {0x2a5203c, 0x8, 0x8}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x68 fp=0x2d53a50 sp=0x2d53a10 pc=0x498164 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x2a52008, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xb4 fp=0x2d53b10 sp=0x2d53a50 pc=0x49b01c Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).readLoop(0x2a52008, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x3c fp=0x2d53bd4 sp=0x2d53b10 pc=0x49ab08 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).reader(0x2a52008, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0xec fp=0x2d53c58 sp=0x2d53bd4 pc=0x49bc20 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).Reader(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).Read(0x2a52008, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x30 fp=0x2d53c80 sp=0x2d53c58 pc=0x49a0a0 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*ConcreteApiServer).serve.func17({0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/api_server.go:636 +0x3b0 fp=0x2d53cfc sp=0x2d53c80 pc=0x6a062c Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.HandlerFunc.ServeHTTP(0x28323c0, {0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2d53d0c sp=0x2d53cfc pc=0x33cf4c Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*ServeMux).ServeHTTP(0x2872380, {0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x2d53d4c sp=0x2d53d0c pc=0x33ee3c Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x2d53d74 sp=0x2d53d4c pc=0x69ffa8 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.HandlerFunc.ServeHTTP(0x2810460, {0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2d53d84 sp=0x2d53d74 pc=0x33cf4c Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.serverHandler.ServeHTTP({0x299e378}, {0xa25968, 0x2d17558}, 0x295a2c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x2d53da0 sp=0x2d53d84 pc=0x35c2b8 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*conn).serve(0x2964120, {0xa260c8, 0x2828588}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x2d53fdc sp=0x2d53da0 pc=0x33b008 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Server).Serve.gowrap3() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x2d53fec sp=0x2d53fdc pc=0x340d40 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2d53fec sp=0x2d53fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by net/http.(*Server).Serve in goroutine 23 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:3493 +0x42c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 36 gp=0x28826c8 m=nil [GC worker (idle), 5 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d90, 0x2c24400, 0x1c, 0xa, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2849788 sp=0x2849774 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkWorker(0x28a1840) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x28497e4 sp=0x2849788 pc=0x49f34 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x28497ec sp=0x28497e4 pc=0x49e14 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28497ec sp=0x28497ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 37 gp=0x28827e8 m=nil [GC worker (idle), 4 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d90, 0x2c24600, 0x1c, 0xa, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b2bf88 sp=0x2b2bf74 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkWorker(0x28a1840) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2b2bfe4 sp=0x2b2bf88 pc=0x49f34 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2b2bfec sp=0x2b2bfe4 pc=0x49e14 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b2bfec sp=0x2b2bfec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 38 gp=0x2882908 m=nil [GC worker (idle)]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d90, 0x2c24800, 0x1c, 0xa, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bcbf88 sp=0x2bcbf74 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkWorker(0x28a1840) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2bcbfe4 sp=0x2bcbf88 pc=0x49f34 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2bcbfec sp=0x2bcbfe4 pc=0x49e14 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bcbfec sp=0x2bcbfec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 39 gp=0x2882a28 m=nil [GC worker (idle), 4 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d90, 0x2c24a00, 0x1c, 0xa, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b30788 sp=0x2b30774 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkWorker(0x28a1840) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2b307e4 sp=0x2b30788 pc=0x49f34 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gcBgMarkStartWorkers.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2b307ec sp=0x2b307e4 pc=0x49e14 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b307ec sp=0x2b307ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 29 gp=0x2882b48 m=nil [IO wait]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb57c3a10, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bcde88 sp=0x2bcde74 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb57c3a00, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2bcdea0 sp=0x2bcde88 pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb57c3a00, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2bcdeb4 sp=0x2bcdea0 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x2cff328, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2bcdec8 sp=0x2bcdeb4 pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).RawRead(0x2cff310, 0x2a8b2c0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x154 fp=0x2bcdef4 sp=0x2bcdec8 pc=0x13a168 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*rawConn).Read(0x2896bc8, 0x2a8b2c0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x2bcdf14 sp=0x2bcdef4 pc=0x1bc9b4 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x2b606b0, 0x2a8b290, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x140 fp=0x2bcdf44 sp=0x2bcdf14 pc=0x5b7e28 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x2815388, {0x2b32000, 0x10000, 0x10000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x1a0 fp=0x2bcdf9c sp=0x2bcdf44 pc=0x5bbb1c Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/grandcat/zeroconf.(*Server).recv4(0x2d10d00, 0x2815380) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xdc fp=0x2bcdfe0 sp=0x2bcdf9c pc=0x618bf8 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x2bcdfec sp=0x2bcdfe0 pc=0x6188c8 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bcdfec sp=0x2bcdfec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 43 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 30 gp=0x2882c68 m=nil [IO wait, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb57c3810, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28a8e60 sp=0x28a8e4c pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb57c3800, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x28a8e78 sp=0x28a8e60 pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb57c3800, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x28a8e8c sp=0x28a8e78 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x2cff378, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x28a8ea0 sp=0x28a8e8c pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).RawRead(0x2cff360, 0x2a36030) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x154 fp=0x28a8ecc sp=0x28a8ea0 pc=0x13a168 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*rawConn).Read(0x2896bf0, 0x2a36030) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x28a8eec sp=0x28a8ecc pc=0x1bc9b4 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x2b606c0, 0x2a36000, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x140 fp=0x28a8f1c sp=0x28a8eec pc=0x5b7e28 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Mar 26 17:36:47 middle-room go-librespot[1648]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x28153b8, {0x2a26000, 0x10000, 0x10000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x188 fp=0x28a8f9c sp=0x28a8f1c pc=0x5bf588 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/grandcat/zeroconf.(*Server).recv6(0x2d10d00, 0x28153b0) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xdc fp=0x28a8fe0 sp=0x28a8f9c pc=0x618ddc Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Mar 26 17:36:47 middle-room volumio[1264]: info: Connection to go-librespot Websocket closed Mar 26 17:36:47 middle-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x28a8fec sp=0x28a8fe0 pc=0x61886c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28a8fec sp=0x28a8fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 43 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 507 gp=0x29f3448 m=nil [select]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28a6e94 sp=0x28a6e80 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x28a6fa8, 0x28a6f6c, 0x0, 0x0, 0x5, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x28a6f44 sp=0x28a6e94 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x28f6288) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x144 fp=0x28a6fe4 sp=0x28a6f44 pc=0x494d20 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.newConn.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x28 fp=0x28a6fec sp=0x28a6fe4 pc=0x4949b0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28a6fec sp=0x28a6fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by nhooyr.io/websocket.newConn in goroutine 458 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x578 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 72 gp=0x29f3d48 m=nil [select, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28a8674 sp=0x28a8660 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x28a8780, 0x28a874c, 0x0, 0x0, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x28a8724 sp=0x28a8674 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x2d26c80) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/player/player.go:215 +0x1f4 fp=0x28a87e4 sp=0x28a8724 pc=0x5818e0 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/player/player.go:197 +0x28 fp=0x28a87ec sp=0x28a87e4 pc=0x5814c8 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28a87ec sp=0x28a87ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/player/player.go:197 +0x220 Mar 26 17:36:47 middle-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 73 gp=0x29f3e68 m=nil [select, 4 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a61930 sp=0x2a6191c pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x2a61f70, 0x2a61b20, 0x0, 0x0, 0xa, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2a619e0 sp=0x2a61930 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*AppPlayer).Run(0x2cff3b0, {0xa260ac, 0xfdcff0}, 0x2c0e1c0, 0x2c0e200) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/player.go:661 +0x368 fp=0x2a61fd4 sp=0x2a619e0 pc=0x6b3970 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).withAppPlayer.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:274 +0x48 fp=0x2a61fec sp=0x2a61fd4 pc=0x6abe18 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a61fec sp=0x2a61fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:274 +0x410 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 74 gp=0x2882ea8 m=nil [chan receive, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d64, 0x2918138, 0xe, 0x7, 0x2) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2849f3c sp=0x2849f28 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv(0x2918100, 0x2849fd0, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2849f84 sp=0x2849f3c pc=0x3414c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv2(0x2918100, 0x2849fd0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x2849f98 sp=0x2849f84 pc=0x33bf0 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).withAppPlayer.func1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:284 +0x68 fp=0x2849fec sp=0x2849f98 pc=0x6abd40 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2849fec sp=0x2849fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:281 +0x49c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 75 gp=0x2882fc8 m=nil [chan receive, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d64, 0x29180f8, 0xe, 0x7, 0x2) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2846f40 sp=0x2846f2c pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv(0x29180c0, 0x2846fe0, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2846f88 sp=0x2846f40 pc=0x3414c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv2(0x29180c0, 0x2846fe0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x2846f9c sp=0x2846f88 pc=0x33bf0 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*App).withAppPlayer.func2() Mar 26 17:36:47 middle-room systemd[1]: go-librespot-daemon.service: Consumed 2min 51.352s CPU time. Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:300 +0x6c fp=0x2846fec sp=0x2846f9c pc=0x6ab8a4 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2846fec sp=0x2846fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by main.(*App).withAppPlayer in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/main.go:297 +0x53c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 76 gp=0x2883448 m=nil [IO wait, 364 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb57c3c10, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284b5ac sp=0x284b598 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb57c3c00, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x284b5c4 sp=0x284b5ac pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb57c3c00, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x284b5d8 sp=0x284b5c4 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x2cff2d8, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x284b5ec sp=0x284b5d8 pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).Accept(0x2cff2c0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x284b634 sp=0x284b5ec pc=0x1395b0 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*netFD).accept(0x2cff2c0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x284b69c sp=0x284b634 pc=0x1aa9d8 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*TCPListener).accept(0x2815320) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x284b6f0 sp=0x284b69c pc=0x1c2304 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*TCPListener).Accept(0x2815320) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x284b70c sp=0x284b6f0 pc=0x1c134c Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*onceCloseListener).Accept(0x2b64880) Mar 26 17:36:47 middle-room go-librespot[1648]: :1 +0x34 fp=0x284b724 sp=0x284b70c pc=0x367710 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Server).Serve(0x2d16798, {0xa258a8, 0x2815320}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x284b7bc sp=0x284b724 pc=0x3408c8 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.Serve(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/server.go:2971 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x284b7ec sp=0x284b7bc pc=0x61dc08 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284b7ec sp=0x284b7ec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/zeroconf/zeroconf.go:280 +0x154 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 101 gp=0x29f3328 m=nil [runnable]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.mapaccess2_faststr(0x8458c0, 0x0, {0x903b05, 0x3}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/runtime/maps/runtime_faststr_swiss.go:162 +0x3cc fp=0x2856b20 sp=0x2856b20 pc=0x2d4e8 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.FieldMap.resolve(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/json_formatter.go:16 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.prefixFieldClashes(0x2856d54, 0x0, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/formatter.go:49 +0x170 fp=0x2856ba0 sp=0x2856b20 pc=0x590354 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*TextFormatter).Format(0x2916900, 0x2b20140) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/text_formatter.go:138 +0x160 fp=0x2856dd0 sp=0x2856ba0 pc=0x5940b8 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*Entry).write(0x2b20140) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:289 +0x8c fp=0x2856e14 sp=0x2856dd0 pc=0x58f4e8 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*Entry).log(0x2916940, 0x6, {0x2812150, 0x10}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x494 fp=0x2856ed4 sp=0x2856e14 pc=0x58f0e0 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*Entry).Log(0x2916940, 0x6, {0x2856f0c, 0x1, 0x1}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x78 fp=0x2856eec sp=0x2856ed4 pc=0x58f72c Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*Entry).Logf(0x2916940, 0x6, {0x90afa3, 0x10}, {0x0, 0x0, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:349 +0xc0 fp=0x2856f14 sp=0x2856eec pc=0x58fac8 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/sirupsen/logrus.(*Entry).Tracef(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:354 Mar 26 17:36:47 middle-room go-librespot[1648]: main.LogrusAdapter.Tracef(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/cmd/daemon/log.go:13 Mar 26 17:36:47 middle-room go-librespot[1648]: main.(*LogrusAdapter).Tracef(0x2913758, {0x90afa3, 0x10}, {0x0, 0x0, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: :1 +0x68 fp=0x2856f34 sp=0x2856f14 pc=0x6b5998 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x2d166e8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:159 +0x3c0 fp=0x2856fe4 sp=0x2856f34 pc=0x5a1030 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:129 +0x28 fp=0x2856fec sp=0x2856fe4 pc=0x5a2c40 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2856fec sp=0x2856fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 73 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:129 +0x15c Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 119 gp=0x2883c28 m=nil [select, 4830 minutes]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284ae94 sp=0x284ae80 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x284afa8, 0x284af6c, 0x0, 0x0, 0x5, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x284af44 sp=0x284ae94 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x2a52008) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x144 fp=0x284afe4 sp=0x284af44 pc=0x494d20 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.newConn.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x28 fp=0x284afec sp=0x284afe4 pc=0x4949b0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284afec sp=0x284afec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by nhooyr.io/websocket.newConn in goroutine 86 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x578 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 545 gp=0x2883e68 m=nil [select]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b2fee4 sp=0x2b2fed0 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x2b2ffd4, 0x2b2ffb8, 0x0, 0x0, 0x2, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2b2ff94 sp=0x2b2fee4 pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).handshakeContext.func2() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1551 +0x98 fp=0x2b2ffec sp=0x2b2ff94 pc=0x26b4cc Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b2ffec sp=0x2b2ffec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by crypto/tls.(*Conn).handshakeContext in goroutine 544 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1550 +0x220 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 544 gp=0x2be5448 m=nil [IO wait]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb4d66210, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a77a4c sp=0x2a77a38 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb4d66200, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a77a64 sp=0x2a77a4c pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb4d66200, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a77a78 sp=0x2a77a64 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x2c30e78, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a77a8c sp=0x2a77a78 pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).Read(0x2c30e60, {0x2bac240, 0x240, 0x240}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2a77ad4 sp=0x2a77a8c pc=0x135f74 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*netFD).Read(0x2c30e60, {0x2bac240, 0x240, 0x240}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2a77b00 sp=0x2a77ad4 pc=0x1a8c28 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*conn).Read(0x2aae000, {0x2bac240, 0x240, 0x240}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2a77b2c sp=0x2a77b00 pc=0x1b842c Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*atLeastReader).Read(0x2b6a150, {0x2bac240, 0x240, 0x240}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2a77b58 sp=0x2a77b2c pc=0x266c34 Mar 26 17:36:47 middle-room go-librespot[1648]: bytes.(*Buffer).ReadFrom(0x299accc, {0xa22858, 0x2b6a150}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2a77b94 sp=0x2a77b58 pc=0x160e08 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readFromUntil(0x299ab48, {0xa21798, 0x2aae000}, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2a77bbc sp=0x2a77b94 pc=0x266e90 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readRecordOrCCS(0x299ab48, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2a77d1c sp=0x2a77bbc pc=0x2645b4 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readRecord(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:589 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readHandshakeBytes(0x299ab48, 0x4) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1085 +0x70 fp=0x2a77d30 sp=0x2a77d1c pc=0x2683e0 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readHandshake(0x299ab48, {0x0, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1096 +0x24 fp=0x2a77d84 sp=0x2a77d30 pc=0x268440 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).clientHandshake(0x299ab48, {0xa260e4, 0x2814000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/handshake_client.go:328 +0x4c0 fp=0x2a77e98 sp=0x2a77d84 pc=0x274584 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).clientHandshake-fm({0xa260e4, 0x2814000}) Mar 26 17:36:47 middle-room go-librespot[1648]: :1 +0x38 fp=0x2a77eb0 sp=0x2a77e98 pc=0x2b2c48 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).handshakeContext(0x299ab48, {0xa260e4, 0x2a8b410}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1575 +0x2e8 fp=0x2a77fb0 sp=0x2a77eb0 pc=0x26ae44 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).HandshakeContext(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1515 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*persistConn).addTLS.func2() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1706 +0x78 fp=0x2a77fec sp=0x2a77fb0 pc=0x352928 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a77fec sp=0x2a77fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by net/http.(*persistConn).addTLS in goroutine 565 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1702 +0x2e4 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 508 gp=0x2d026c8 m=nil [IO wait]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960ecc, 0xb57c3210, 0x2, 0x2, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bca95c sp=0x2bca948 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.netpollblock(0xb57c3200, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2bca974 sp=0x2bca95c pc=0x675a0 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.runtime_pollWait(0xb57c3200, 0x72) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2bca988 sp=0x2bca974 pc=0xa8864 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).wait(0x2ad02e8, 0x72, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2bca99c sp=0x2bca988 pc=0x134df4 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*pollDesc).waitRead(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Mar 26 17:36:47 middle-room go-librespot[1648]: internal/poll.(*FD).Read(0x2ad02d0, {0x2b16000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2bca9e4 sp=0x2bca99c pc=0x135f74 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*netFD).Read(0x2ad02d0, {0x2b16000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2bcaa10 sp=0x2bca9e4 pc=0x1a8c28 Mar 26 17:36:47 middle-room go-librespot[1648]: net.(*conn).Read(0x28961a0, {0x2b16000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2bcaa3c sp=0x2bcaa10 pc=0x1b842c Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*atLeastReader).Read(0x2b9c230, {0x2b16000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2bcaa68 sp=0x2bcaa3c pc=0x266c34 Mar 26 17:36:47 middle-room go-librespot[1648]: bytes.(*Buffer).ReadFrom(0x292e84c, {0xa22858, 0x2b9c230}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2bcaaa4 sp=0x2bcaa68 pc=0x160e08 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readFromUntil(0x292e6c8, {0xa21798, 0x28961a0}, 0x5) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2bcaacc sp=0x2bcaaa4 pc=0x266e90 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readRecordOrCCS(0x292e6c8, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2bcac2c sp=0x2bcaacc pc=0x2645b4 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).readRecord(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:589 Mar 26 17:36:47 middle-room go-librespot[1648]: crypto/tls.(*Conn).Read(0x292e6c8, {0x2aee000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2bcac5c sp=0x2bcac2c pc=0x26a378 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*readWriteCloserBody).Read(0x2810500, {0x2aee000, 0x1000, 0x1000}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:2578 +0xec fp=0x2bcac7c sp=0x2bcac5c pc=0x3577bc Mar 26 17:36:47 middle-room go-librespot[1648]: bufio.(*Reader).fill(0x28faa80) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2bcaca0 sp=0x2bcac7c pc=0x2b6390 Mar 26 17:36:47 middle-room go-librespot[1648]: bufio.(*Reader).ReadByte(0x28faa80) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2bcacac sp=0x2bcaca0 pc=0x2b6c0c Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.readFrameHeader(0x28faa80, {0x28f62bc, 0x8, 0x8}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x68 fp=0x2bcacec sp=0x2bcacac pc=0x498164 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x28f6288, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xb4 fp=0x2bcadac sp=0x2bcacec pc=0x49b01c Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).readLoop(0x28f6288, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x3c fp=0x2bcae70 sp=0x2bcadac pc=0x49ab08 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).reader(0x28f6288, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0xec fp=0x2bcaef4 sp=0x2bcae70 pc=0x49bc20 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).Reader(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Mar 26 17:36:47 middle-room go-librespot[1648]: nhooyr.io/websocket.(*Conn).Read(0x28f6288, {0xa26090, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x30 fp=0x2bcaf1c sp=0x2bcaef4 pc=0x49a0a0 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x2d166e8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:188 +0x58 fp=0x2bcafe4 sp=0x2bcaf1c pc=0x5a1198 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:296 +0x28 fp=0x2bcafec sp=0x2bcafe4 pc=0x5a1df4 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bcafec sp=0x2bcafec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).reconnect in goroutine 458 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/dealer/dealer.go:296 +0xf8 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 527 gp=0x29f2b48 m=nil [select]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960f10, 0x0, 0x9, 0x3, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bc950c sp=0x2bc94f8 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.selectgo(0x2bc966c, 0x2bc95e4, 0x0, 0x0, 0x2, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2bc95bc sp=0x2bc950c pc=0x85000 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).getConn(0xf812a8, 0x2a8b3e0, {{}, 0x0, {0x917af4, 0x5}, {0x2936d80, 0x19}, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1523 +0x370 fp=0x2bc96b8 sp=0x2bc95bc pc=0x351440 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).roundTrip(0xf812a8, 0x2bb02c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:685 +0x978 fp=0x2bc97a4 sp=0x2bc96b8 pc=0x34d528 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).RoundTrip(0xf812a8, 0x2bb02c8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/roundtrip.go:33 +0x2c fp=0x2bc97bc sp=0x2bc97a4 pc=0x35ba84 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.send(0x2bb00b8, {0xa21b28, 0xf812a8}, {0xc26979934b4b7e9f, 0x1079994867233, 0xfd1e68}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/client.go:259 +0x53c fp=0x2bc98e8 sp=0x2bc97bc pc=0x2ed3ec Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Client).send(0x2915100, 0x2bb00b8, {0xc26979934b4b7e9f, 0x1079994867233, 0xfd1e68}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/client.go:180 +0x98 fp=0x2bc992c sp=0x2bc98e8 pc=0x2eccd8 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Client).do(0x2915100, 0x2bb00b8) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/client.go:729 +0x9a8 fp=0x2bc9a3c sp=0x2bc992c pc=0x2ef340 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Client).Do(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/client.go:587 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).fetchUrls(0x29522a0, {0xa2611c, 0x2c30870}, {0x2bc9cb0, 0x1, 0x1}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/apresolve/resolve.go:83 +0x4d0 fp=0x2bc9c74 sp=0x2bc9a3c pc=0x597990 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).get(0x29522a0, {0xa2611c, 0x2c30870}, {0x907726, 0xb}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/apresolve/resolve.go:126 +0x84 fp=0x2bc9cbc sp=0x2bc9c74 pc=0x598514 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).getFunc.func1({0xa2611c, 0x2c30870}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/apresolve/resolve.go:157 +0x90 fp=0x2bc9d08 sp=0x2bc9cbc pc=0x598918 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0x299fce8, {0xa260ac, 0xfdcff0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:94 +0x26c fp=0x2bc9d80 sp=0x2bc9d08 pc=0x4f4938 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0x299fce8, {0xa260ac, 0xfdcff0}, 0x2a8b350) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:205 +0xd4 fp=0x2bc9de4 sp=0x2bc9d80 pc=0x4f5a7c Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0x299fce8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:394 +0xcc fp=0x2bc9e0c sp=0x2bc9de4 pc=0x4f703c Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() Mar 26 17:36:47 middle-room go-librespot[1648]: :1 +0x28 fp=0x2bc9e1c sp=0x2bc9e0c pc=0x4fb294 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x1c fp=0x2bc9e28 sp=0x2bc9e1c pc=0x4ea1ec Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x2bc9ecc, {0xa24f50, 0x2d24360}, 0x0, {0x0, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0xcc fp=0x2bc9ea4 sp=0x2bc9e28 pc=0x4ea668 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x2bc9f5c, {0xa24f50, 0x2d24360}, 0x0, {0x0, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x5c fp=0x2bc9ed4 sp=0x2bc9ea4 pc=0x4ea1a4 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/cenkalti/backoff/v4.RetryNotify(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/cenkalti/backoff/v4.Retry(...) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x299fce8) Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:335 +0x434 fp=0x2bc9fe4 sp=0x2bc9ed4 pc=0x4f689c Mar 26 17:36:47 middle-room go-librespot[1648]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1() Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:403 +0x28 fp=0x2bc9fec sp=0x2bc9fe4 pc=0x4f71f0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bc9fec sp=0x2bc9fec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 464 Mar 26 17:36:47 middle-room go-librespot[1648]: /src/ap/ap.go:403 +0x120 Mar 26 17:36:47 middle-room go-librespot[1648]: goroutine 565 gp=0x29f2d88 m=nil [chan receive]: Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.gopark(0x960d64, 0x2b20078, 0xe, 0x7, 0x2) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2bcfb44 sp=0x2bcfb30 pc=0xa97c0 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv(0x2b20040, 0x2bcfca0, 0x1) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2bcfb8c sp=0x2bcfb44 pc=0x3414c Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.chanrecv1(0x2b20040, 0x2bcfca0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x2bcfba0 sp=0x2bcfb8c pc=0x33bcc Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*persistConn).addTLS(0x2bb0378, {0xa260e4, 0x2a8b410}, {0x2936d80, 0x15}, 0x0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1712 +0x308 fp=0x2bcfcac sp=0x2bcfba0 pc=0x352684 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).dialConn(0xf812a8, {0xa260e4, 0x2a8b410}, {{}, 0x0, {0x917af4, 0x5}, {0x2936d80, 0x19}, 0x0}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1793 +0x898 fp=0x2bcff60 sp=0x2bcfcac pc=0x3532a4 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).dialConnFor(0xf812a8, 0x2d243c0) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1618 +0x80 fp=0x2bcffc4 sp=0x2bcff60 pc=0x351e80 Mar 26 17:36:47 middle-room go-librespot[1648]: net/http.(*Transport).startDialConnForLocked.func1() Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1600 +0x3c fp=0x2bcffec sp=0x2bcffc4 pc=0x351d08 Mar 26 17:36:47 middle-room go-librespot[1648]: runtime.goexit({}) Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2bcffec sp=0x2bcffec pc=0xb0874 Mar 26 17:36:47 middle-room go-librespot[1648]: created by net/http.(*Transport).startDialConnForLocked in goroutine 527 Mar 26 17:36:47 middle-room go-librespot[1648]: /usr/local/go/src/net/http/transport.go:1599 +0x134 Mar 26 17:36:47 middle-room go-librespot[1644]: Aborted Mar 26 17:36:50 middle-room volumio[1264]: info: Initializing connection to go-librespot Websocket Mar 26 17:36:50 middle-room volumio[1264]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Mar 26 17:36:50 middle-room systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Mar 26 17:36:50 middle-room systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Mar 26 17:36:50 middle-room systemd[1]: go-librespot-daemon.service: Consumed 2min 51.352s CPU time. Mar 26 17:36:50 middle-room systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Mar 26 17:36:50 middle-room go-librespot[717]: go-librespot daemon starting... Mar 26 17:36:50 middle-room go-librespot[718]: time="2026-03-26T17:36:50Z" level=info msg="running go-librespot 0.6.2" Mar 26 17:36:50 middle-room go-librespot[718]: time="2026-03-26T17:36:50Z" level=debug msg="app state loaded" Mar 26 17:36:50 middle-room go-librespot[718]: time="2026-03-26T17:36:50Z" level=info msg="api server listening on 127.0.0.1:9879" Mar 26 17:36:53 middle-room volumio[1264]: info: Initializing connection to go-librespot Websocket Mar 26 17:36:53 middle-room go-librespot[718]: time="2026-03-26T17:36:53Z" level=debug msg="new websocket client" Mar 26 17:36:53 middle-room volumio[1264]: info: Connection to go-librespot Websocket established Mar 26 17:36:56 middle-room volumio[1264]: info: Getting Spotify volume Mar 26 17:36:56 middle-room volumio[1264]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 26 17:36:56 middle-room volumio[1264]: info: CoreCommandRouter::volumioGetState Mar 26 17:36:56 middle-room volumio[1264]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Mar 26 17:37:01 middle-room go-librespot[718]: time="2026-03-26T17:37:01Z" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": net/http: TLS handshake timeout" Mar 26 17:37:01 middle-room systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Mar 26 17:37:01 middle-room systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Mar 26 17:37:01 middle-room volumio[1264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 17:37:01 middle-room volumio[1264]: Error: socket hang up Mar 26 17:37:01 middle-room volumio[1264]: at connResetException (node:internal/errors:720:14) Mar 26 17:37:01 middle-room volumio[1264]: at Socket.socketOnEnd (node:_http_client:519:23) Mar 26 17:37:01 middle-room volumio[1264]: at Socket.emit (node:events:526:35) Mar 26 17:37:01 middle-room volumio[1264]: at endReadableNT (node:internal/streams/readable:1376:12) Mar 26 17:37:01 middle-room volumio[1264]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Mar 26 17:37:01 middle-room volumio[1264]: code: 'ECONNRESET', Mar 26 17:37:01 middle-room volumio[1264]: response: undefined Mar 26 17:37:01 middle-room volumio[1264]: } Mar 26 17:37:01 middle-room volumio[1264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 17:37:02 middle-room sudo[756]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 17:36' Mar 26 17:37:02 middle-room sudo[756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"