Jan 26 11:51:05 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:05+02:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:443, retrying with a different AP" error="dial tcp: lookup ap-gew4.spotify.com: device or resource busy" Jan 26 11:51:05 volumio-pc systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jan 26 11:51:16 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:16+02:00" level=trace msg="sent dealer ping" Jan 26 11:51:16 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:16+02:00" level=trace msg="received dealer pong" Jan 26 11:51:17 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:17+02:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:80, retrying with a different AP" error="dial tcp: lookup ap-gae2.spotify.com: device or resource busy" Jan 26 11:51:19 volumio-pc volumiossh-tunnel[48240]: Timeout, server eu6.myvolumio.org not responding. Jan 26 11:51:19 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:51:19 volumio-pc autossh[2189]: starting ssh (count 11) Jan 26 11:51:19 volumio-pc autossh[2189]: ssh child pid is 142850 Jan 26 11:51:29 volumio-pc go-librespot[1912]: time="2026-01-26T11:51: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" Jan 26 11:51:29 volumio-pc volumiossh-tunnel[142850]: ssh: Could not resolve hostname eu6.myvolumio.org: Device or resource busy Jan 26 11:51:29 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:51:29 volumio-pc autossh[2189]: starting ssh (count 12) Jan 26 11:51:29 volumio-pc autossh[2189]: ssh child pid is 142878 Jan 26 11:51:41 volumio-pc volumiossh-tunnel[142878]: ssh: Could not resolve hostname eu6.myvolumio.org: Device or resource busy Jan 26 11:51:41 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:51:41 volumio-pc autossh[2189]: starting ssh (count 13) Jan 26 11:51:41 volumio-pc autossh[2189]: ssh child pid is 142909 Jan 26 11:51:46 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:46+02:00" level=trace msg="sent dealer ping" Jan 26 11:51:46 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:46+02:00" level=trace msg="received dealer pong" Jan 26 11:51:53 volumio-pc go-librespot[1912]: time="2026-01-26T11:51:53+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" Jan 26 11:51:53 volumio-pc volumiossh-tunnel[142909]: ssh: Could not resolve hostname eu6.myvolumio.org: Device or resource busy Jan 26 11:51:53 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:51:53 volumio-pc autossh[2189]: starting ssh (count 14) Jan 26 11:51:53 volumio-pc autossh[2189]: ssh child pid is 142938 Jan 26 11:52:05 volumio-pc go-librespot[1912]: time="2026-01-26T11:52:05+02:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp: lookup ap-gew1.spotify.com: device or resource busy" Jan 26 11:52:05 volumio-pc volumiossh-tunnel[142938]: ssh: Could not resolve hostname eu6.myvolumio.org: Device or resource busy Jan 26 11:52:05 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:52:05 volumio-pc autossh[2189]: starting ssh (count 15) Jan 26 11:52:05 volumio-pc autossh[2189]: ssh child pid is 142984 Jan 26 11:52:16 volumio-pc go-librespot[1912]: time="2026-01-26T11:52:16+02:00" level=error msg="did not receive last pong ack from accesspoint, 240s passed" Jan 26 11:52:16 volumio-pc go-librespot[1912]: panic: runtime error: invalid memory address or nil pointer dereference Jan 26 11:52:16 volumio-pc go-librespot[1912]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x18 pc=0x8a63fb] Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 33 gp=0xc0003881c0 m=3 mp=0xc000063008 [running]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: panic({0xba9580?, 0x13f6450?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/panic.go:802 +0x168 fp=0xc000504ed8 sp=0xc000504e28 pc=0x4889e8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.panicmem(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/panic.go:262 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.sigpanic() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/signal_unix.go:925 +0x359 fp=0xc000504f38 sp=0xc000504ed8 pc=0x48afb9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0xc00036c0f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:380 +0x1fb fp=0xc000504fc8 sp=0xc000504f38 pc=0x8a63fb Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:277 +0x25 fp=0xc000504fe0 sp=0xc000504fc8 pc=0x8a5905 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000504fe8 sp=0xc000504fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 42 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:277 +0xff Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 1 gp=0xc000002380 m=nil [select, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc000045c60?, 0x2?, 0xf0?, 0xe6?, 0xc000045bfc?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000325a70 sp=0xc000325a50 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc000325c60, 0xc000045bf8, 0x0?, 0x0, 0xbe7660?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000325bb0 sp=0xc000325a70 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0xc0002fe0a0, 0xc000325d80) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/zeroconf/zeroconf.go:283 +0x29a fp=0xc000325cf8 sp=0xc000325bb0 pc=0x9a379a Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).withAppPlayer(0xc00021ad00, {0xe0b228, 0x1483020}, 0xc000306840) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:340 +0x590 fp=0xc000325e10 sp=0xc000325cf8 pc=0xa30810 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).withCredentials(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:209 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).SpotifyToken(0xc00021ad00, {0xe0b228, 0x1483020}, {0xc0001c8e60?, 0xce6b7b?}, {0xc0001983c0?, 0x2697?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:201 +0xc5 fp=0xc000325e68 sp=0xc000325e10 pc=0xa2fcc5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.main() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:593 +0x745 fp=0xc000325f50 sp=0xc000325e68 pc=0xa32965 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.main() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:285 +0x29d fp=0xc000325fe0 sp=0xc000325f50 pc=0x45509d Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000325fe8 sp=0xc000325fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 2 gp=0xc000002e00 m=nil [force gc (idle), 3 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x2f06ea3067e9?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005cfa8 sp=0xc00005cf88 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goparkunlock(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:466 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.forcegchelper() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:373 +0xb3 fp=0xc00005cfe0 sp=0xc00005cfa8 pc=0x4553d3 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005cfe8 sp=0xc00005cfe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.init.7 in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:361 +0x1a Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 3 gp=0xc000003340 m=nil [GC sweep wait]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x1?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005d780 sp=0xc00005d760 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goparkunlock(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:466 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.bgsweep(0xc00007e000) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgcsweep.go:323 +0xdf fp=0xc00005d7c8 sp=0xc00005d780 pc=0x43f29f Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcenable.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:212 +0x25 fp=0xc00005d7e0 sp=0xc00005d7c8 pc=0x4332a5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005d7e8 sp=0xc00005d7e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcenable in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:212 +0x66 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 4 gp=0xc000003500 m=nil [GC scavenge wait]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x1461b00?, 0x3b9aca00?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005df78 sp=0xc00005df58 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goparkunlock(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:466 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.(*scavengerState).park(0x1461b00) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc00005dfa8 sp=0xc00005df78 pc=0x43cd29 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.bgscavenge(0xc00007e000) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0xc00005dfc8 sp=0xc00005dfa8 pc=0x43d2d9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcenable.gowrap2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:213 +0x25 fp=0xc00005dfe0 sp=0xc00005dfc8 pc=0x433245 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005dfe8 sp=0xc00005dfe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcenable in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:213 +0xa5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 18 gp=0xc000180000 m=nil [GOMAXPROCS updater (idle), 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000058788 sp=0xc000058768 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goparkunlock(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:466 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.updateMaxProcsGoroutine() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:6720 +0xe7 fp=0xc0000587e0 sp=0xc000058788 pc=0x4632c7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000587e8 sp=0xc0000587e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:6708 +0x37 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 19 gp=0xc000180540 m=nil [finalizer wait, 859 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x0?, 0xd41d08?, 0x0?, 0xc0?, 0x2000000020?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005c620 sp=0xc00005c600 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.runFinalizers() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mfinal.go:210 +0x107 fp=0xc00005c7e0 sp=0xc00005c620 pc=0x4321a7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005c7e8 sp=0xc00005c7e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.createfing in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mfinal.go:172 +0x3d Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 20 gp=0xc000181340 m=nil [cleanup wait, 859 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x7f956168a200?, 0xc000058f90?, 0xb5?, 0x7a?, 0x7f956168a200?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000058f68 sp=0xc000058f48 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goparkunlock(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:466 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.(*cleanupQueue).dequeue(0x1461f40) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mcleanup.go:439 +0xc5 fp=0xc000058fa0 sp=0xc000058f68 pc=0x42f3c5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.runCleanups() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mcleanup.go:635 +0x45 fp=0xc000058fe0 sp=0xc000058fa0 pc=0x42fa85 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000058fe8 sp=0xc000058fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mcleanup.go:589 +0xa5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 23 gp=0xc0001816c0 m=nil [IO wait, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000071a58 sp=0xc000071a38 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0xc000071aa8?, 0x41f886?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000071a90 sp=0xc000071a58 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95620b1e00, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000071ab0 sp=0xc000071a90 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc000218900?, 0x900000036?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000071ad8 sp=0xc000071ab0 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).Accept(0xc000218900) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc000071b80 sp=0xc000071ad8 pc=0x50fc4c Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*netFD).accept(0xc000218900) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc000071c38 sp=0xc000071b80 pc=0x57c449 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*TCPListener).accept(0xc0001ad2c0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc000071c88 sp=0xc000071c38 pc=0x591bbb Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*TCPListener).Accept(0xc0001ad2c0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc000071cb8 sp=0xc000071c88 pc=0x590d90 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*onceCloseListener).Accept(0xc00001a3f0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: :1 +0x24 fp=0xc000071cd0 sp=0xc000071cb8 pc=0x73aaa4 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Server).Serve(0xc0000b4000, {0xe0a190, 0xc0001ad2c0}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc000071e00 sp=0xc000071cd0 pc=0x712a0c Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.Serve(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2971 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*ConcreteApiServer).serve(0xc0002e03f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/api_server.go:666 +0x90c fp=0xc000071fc8 sp=0xc000071e00 pc=0xa25c4c Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.NewApiServer.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/api_server.go:332 +0x25 fp=0xc000071fe0 sp=0xc000071fc8 pc=0xa24985 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000071fe8 sp=0xc000071fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by main.NewApiServer in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/api_server.go:332 +0x2ff Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 41 gp=0xc000181880 m=nil [select, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00005f720?, 0x3?, 0xdf?, 0x90?, 0xc00005f6da?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005f560 sp=0xc00005f540 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc00005f720, 0xc00005f6d4, 0xc00005f774?, 0x0, 0x3?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00005f6a0 sp=0xc00005f560 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0xc0002f6780) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/player/player.go:215 +0x205 fp=0xc00005f7c8 sp=0xc00005f6a0 pc=0x911e65 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/player/player.go:197 +0x25 fp=0xc00005f7e0 sp=0xc00005f7c8 pc=0x911a25 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005f7e8 sp=0xc00005f7e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/player/player.go:197 +0x1e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 7 gp=0xc0003896c0 m=nil [GC worker (idle), 3 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x2f06ea59ce9d?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000502f38 sp=0xc000502f18 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkWorker(0xc0000bd730) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc000502fc8 sp=0xc000502f38 pc=0x43598b Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkStartWorkers.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc000502fe0 sp=0xc000502fc8 pc=0x435865 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000502fe8 sp=0xc000502fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 8 gp=0xc000389880 m=nil [GC worker (idle), 255 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x214685073e1b?, 0x3?, 0x45?, 0xb6?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000118738 sp=0xc000118718 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkWorker(0xc0000bd730) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc0001187c8 sp=0xc000118738 pc=0x43598b Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkStartWorkers.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc0001187e0 sp=0xc0001187c8 pc=0x435865 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001187e8 sp=0xc0001187e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 9 gp=0xc000389a40 m=nil [GC worker (idle), 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xabad637fb?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005ef38 sp=0xc00005ef18 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkWorker(0xc0000bd730) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00005efc8 sp=0xc00005ef38 pc=0x43598b Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkStartWorkers.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00005efe0 sp=0xc00005efc8 pc=0x435865 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005efe8 sp=0xc00005efe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 10 gp=0xc000389c00 m=nil [GC worker (idle), 633 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xca5e880bd36?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00011b738 sp=0xc00011b718 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkWorker(0xc0000bd730) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00011b7c8 sp=0xc00011b738 pc=0x43598b Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gcBgMarkStartWorkers.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00011b7e0 sp=0xc00011b7c8 pc=0x435865 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00011b7e8 sp=0xc00011b7e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 29 gp=0xc000102380 m=nil [IO wait]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x18?, 0xb80860?, 0xc0?, 0xc0?, 0xc3c160?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000507d28 sp=0xc000507d08 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000507d60 sp=0xc000507d28 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95620b1800, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000507d80 sp=0xc000507d60 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc0000ae480?, 0x7f956493bba0?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000507da8 sp=0xc000507d80 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).RawRead(0xc0000ae480, 0xc000422140) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc000507e08 sp=0xc000507da8 pc=0x5108c5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*rawConn).Read(0xc000194050, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc000507e40 sp=0xc000507e08 pc=0x58ccf6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003fc120, 0xc0001ab260, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc000507ea0 sp=0xc000507e40 pc=0x941a85 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0xc0001f0290, {0xc00030e000, 0x10000, 0x10000}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x225 fp=0xc000507f48 sp=0xc000507ea0 pc=0x945265 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/grandcat/zeroconf.(*Server).recv4(0xc0004f20c0, 0xc0001f0280) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xc7 fp=0xc000507fc0 sp=0xc000507f48 pc=0x99e627 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x25 fp=0xc000507fe0 sp=0xc000507fc0 pc=0x99e2c5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000507fe8 sp=0xc000507fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 11 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x78 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 30 gp=0xc000102540 m=nil [IO wait, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x43c21c?, 0x14848c0?, 0x60?, 0xe3?, 0xc000118530?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006ece0 sp=0xc00006ecc0 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006ed18 sp=0xc00006ece0 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95620b1600, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006ed38 sp=0xc00006ed18 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc0000ae500?, 0x7f95ab52d5b0?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006ed60 sp=0xc00006ed38 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).RawRead(0xc0000ae500, 0xc0000a8690) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc00006edc0 sp=0xc00006ed60 pc=0x5108c5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*rawConn).Read(0xc0001940c0, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc00006edf8 sp=0xc00006edc0 pc=0x58ccf6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003fc140, 0xc0001aa120, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc00006ee58 sp=0xc00006edf8 pc=0x941a85 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Jan 26 11:52:16 volumio-pc go-librespot[1912]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0xc0001f0330, {0xc00011c000, 0x10000, 0x10000}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x265 fp=0xc00006ef48 sp=0xc00006ee58 pc=0x948725 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/grandcat/zeroconf.(*Server).recv6(0xc0004f20c0, 0xc0001f0320) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xc7 fp=0xc00006efc0 sp=0xc00006ef48 pc=0x99e7e7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x25 fp=0xc00006efe0 sp=0xc00006efc0 pc=0x99e265 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006efe8 sp=0xc00006efe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 11 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xd9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 89 gp=0xc000388700 m=nil [select]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc0004a35c8?, 0x2?, 0x70?, 0x33?, 0xc0004a3480?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004a3300 sp=0xc0004a32e0 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc0004a35c8, 0xc0004a347c, 0x19?, 0x0, 0x1?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0004a3440 sp=0xc0004a3300 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).lookupIPAddr(0x1460940, {0xe0b308, 0xc000490d90}, {0xce44e8, 0x3}, {0xc00012c2c0, 0x15}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/lookup.go:343 +0x3d9 fp=0xc0004a3620 sp=0xc0004a3440 pc=0x5871f9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).internetAddrList(0x1460940?, {0xe0b308?, 0xc000490d90?}, {0xce44e8, 0x3}, {0xc00012c2c0?, 0xbe8ee0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/ipsock.go:289 +0x4b3 fp=0xc0004a3708 sp=0xc0004a3620 pc=0x5854f3 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).resolveAddrList(0x1460940, {0xe0b308, 0xc000490d90}, {0xce48f8, 0x4}, {0xce44e8?, 0x4ae3b9?}, {0xc00012c2c0, 0x19}, {0x0, ...}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/dial.go:353 +0x3e5 fp=0xc0004a3808 sp=0xc0004a3708 pc=0x570265 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Dialer).DialContext(0xc0002e01b0, {0xe0b298, 0xc000422b90}, {0xce44e8, 0x3}, {0xc00012c2c0, 0x19}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/dial.go:560 +0x3f7 fp=0xc0004a3978 sp=0xc0004a3808 pc=0x5710d7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Dialer).DialContext-fm({0xe0b298?, 0xc000422b90?}, {0xce44e8?, 0xcce220?}, {0xc00012c2c0?, 0xc00006da18?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: :1 +0x49 fp=0xc0004a39c0 sp=0xc0004a3978 pc=0x73bba9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).dial(0xc000388700?, {0xe0b298?, 0xc000422b90?}, {0xce44e8?, 0xc0004909a0?}, {0xc00012c2c0?, 0xc000417500?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1278 +0xd2 fp=0xc0004a3a28 sp=0xc0004a39c0 pc=0x721cf2 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).dialConn(0x14090e0, {0xe0b298, 0xc000422b90}, {{}, 0x0, {0xcf7e79, 0x5}, {0xc00012c2c0, 0x19}, 0x0}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1783 +0x7e5 fp=0xc0004a3ee0 sp=0xc0004a3a28 pc=0x724ca5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).dialConnFor(0x14090e0, 0xc000038dc0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1618 +0xb8 fp=0xc0004a3f90 sp=0xc0004a3ee0 pc=0x7237b8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).startDialConnForLocked.func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1600 +0x35 fp=0xc0004a3fe0 sp=0xc0004a3f90 pc=0x7235f5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004a3fe8 sp=0xc0004a3fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by net/http.(*Transport).startDialConnForLocked in goroutine 32 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1599 +0x112 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 90 gp=0xc000003dc0 m=nil [select]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00006db60?, 0x2?, 0x1?, 0x0?, 0xc00006dae4?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006d968 sp=0xc00006d948 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc00006db60, 0xc00006dae0, 0x4?, 0x0, 0x0?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00006daa8 sp=0xc00006d968 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.doBlockingWithCtx[...]({0xe0b298, 0xc000422be0}, {0xc00012c2c0, 0x15}, 0xc0003011d0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:71 +0x29a fp=0xc00006dbc0 sp=0xc00006daa8 pc=0x59bada Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.cgoLookupIP({0xe0b298, 0xc000422be0}, {0xce44e8, 0x3}, {0xc00012c2c0, 0x15}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:228 +0xa5 fp=0xc00006dc00 sp=0xc00006dbc0 pc=0x56de85 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).lookupIP(0x1460940, {0xe0b298, 0xc000422be0}, {0xce44e8, 0x3}, {0xc00012c2c0, 0x15}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/lookup_unix.go:64 +0xe5 fp=0xc00006de58 sp=0xc00006dc00 pc=0x588165 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).lookupIP-fm({0xe0b298?, 0xc000422be0?}, {0xce44e8?, 0x422565?}, {0xc00012c2c0?, 0x4?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: :1 +0x49 fp=0xc00006dea0 sp=0xc00006de58 pc=0x5a17a9 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.init.func1({0xe0b298?, 0xc000422be0?}, 0x0?, {0xce44e8?, 0x3?}, {0xc00012c2c0?, 0x0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/hook.go:21 +0x37 fp=0xc00006dee0 sp=0xc00006dea0 pc=0x56b517 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*Resolver).lookupIPAddr.func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/lookup.go:335 +0x37 fp=0xc00006df38 sp=0xc00006dee0 pc=0x587ab7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/singleflight.(*Group).doCall(0x1460950, 0xc000422c30, {0xc00012c2e0, 0x19}, 0xd41a78?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/singleflight/singleflight.go:93 +0x34 fp=0xc00006dfa8 sp=0xc00006df38 pc=0x56a314 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/singleflight.(*Group).DoChan.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x30 fp=0xc00006dfe0 sp=0xc00006dfa8 pc=0x56a2b0 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006dfe8 sp=0xc00006dfe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by internal/singleflight.(*Group).DoChan in goroutine 89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/singleflight/singleflight.go:86 +0x2cf Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 42 gp=0xc000181dc0 m=nil [select, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00052bed0?, 0xa?, 0x60?, 0xb3?, 0xc00052b6c0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00052b318 sp=0xc00052b2f8 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc00052bed0, 0xc00052b6ac, 0x1483020?, 0x0, 0xa?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00052b458 sp=0xc00052b318 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*AppPlayer).Run(0xc0000ae580, {0xe0b228, 0x1483020}, 0xc0002a08c0, 0xc0002a0930) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/player.go:661 +0x427 fp=0xc00052bfa8 sp=0xc00052b458 pc=0xa38667 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).withAppPlayer.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:274 +0x30 fp=0xc00052bfe0 sp=0xc00052bfa8 pc=0xa31430 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00052bfe8 sp=0xc00052bfe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by main.(*App).withAppPlayer in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:274 +0x3c5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 43 gp=0xc000522000 m=nil [chan receive, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00008a360?, 0xc0004f2540?, 0x0?, 0x0?, 0xc000114ee8?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000114e98 sp=0xc000114e78 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.chanrecv(0xc000182310, 0xc000114f98, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000114f10 sp=0xc000114e98 pc=0x422773 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.chanrecv2(0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000114f38 sp=0xc000114f10 pc=0x4222f2 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).withAppPlayer.func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:284 +0x72 fp=0xc000114fe0 sp=0xc000114f38 pc=0xa31372 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000114fe8 sp=0xc000114fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by main.(*App).withAppPlayer in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:281 +0x45f Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 44 gp=0xc0005221c0 m=nil [chan receive, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000115698 sp=0xc000115678 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.chanrecv(0xc0001822a0, 0xc0001157b8, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000115710 sp=0xc000115698 pc=0x422773 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.chanrecv2(0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000115738 sp=0xc000115710 pc=0x4222f2 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*App).withAppPlayer.func2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:300 +0x87 fp=0xc0001157e0 sp=0xc000115738 pc=0xa30fa7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001157e8 sp=0xc0001157e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by main.(*App).withAppPlayer in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/main.go:297 +0x51f Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 45 gp=0xc000522380 m=nil [IO wait, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000343be0 sp=0xc000343bc0 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0xc000343c50?, 0x41f886?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000343c18 sp=0xc000343be0 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95620b1a00, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000343c38 sp=0xc000343c18 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc0000ae200?, 0x7f95ab5225c0?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000343c60 sp=0xc000343c38 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).Accept(0xc0000ae200) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc000343d08 sp=0xc000343c60 pc=0x50fc4c Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*netFD).accept(0xc0000ae200) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc000343dc0 sp=0xc000343d08 pc=0x57c449 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*TCPListener).accept(0xc0001acdc0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc000343e10 sp=0xc000343dc0 pc=0x591bbb Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*TCPListener).Accept(0xc0001acdc0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc000343e40 sp=0xc000343e10 pc=0x590d90 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*onceCloseListener).Accept(0xe0b1f0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: :1 +0x24 fp=0xc000343e58 sp=0xc000343e40 pc=0x73aaa4 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Server).Serve(0xc000518100, {0xe0a190, 0xc0001acdc0}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc000343f88 sp=0xc000343e58 pc=0x712a0c Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.Serve(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2971 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/zeroconf/zeroconf.go:280 +0x85 fp=0xc000343fe0 sp=0xc000343f88 pc=0x9a38a5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000343fe8 sp=0xc000343fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/zeroconf/zeroconf.go:280 +0x156 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 116 gp=0xc000486000 m=nil [IO wait, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc000327310?, 0x925374?, 0x45?, 0x66?, 0xb?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0003272e0 sp=0xc0003272c0 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000327318 sp=0xc0003272e0 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95617fe800, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000327338 sp=0xc000327318 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc000134280?, 0xc00014a000?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000327360 sp=0xc000327338 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).Read(0xc000134280, {0xc00014a000, 0x1000, 0x1000}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0003273f8 sp=0xc000327360 pc=0x50bb19 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*netFD).Read(0xc000134280, {0xc00014a000?, 0x488f0e?, 0x1?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc000327440 sp=0xc0003273f8 pc=0x57a5a5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*conn).Read(0xc000140060, {0xc00014a000?, 0x2?, 0x45ec3f?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc000327488 sp=0xc000327440 pc=0x588ac5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: io.(*multiReader).Read(0xc000508d38, {0xc00014a000, 0x1000, 0x1000}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/io/multi.go:26 +0x93 fp=0xc0003274d0 sp=0xc000327488 pc=0x4c9a73 Jan 26 11:52:16 volumio-pc go-librespot[1912]: bufio.(*Reader).fill(0xc00029e720) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc000327508 sp=0xc0003274d0 pc=0x68e1c3 Jan 26 11:52:16 volumio-pc go-librespot[1912]: bufio.(*Reader).ReadByte(0xc00029e720) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/bufio/bufio.go:273 +0x27 fp=0xc000327528 sp=0xc000327508 pc=0x68e8e7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.readFrameHeader(0xc00029e720, {0xc00013a208, 0x8, 0x8}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x85 fp=0xc0003275b8 sp=0xc000327528 pc=0x84aa65 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).readFrameHeader(0xc00013a1a0, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xd6 fp=0xc0003276f8 sp=0xc0003275b8 pc=0x84c6b6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).readLoop(0xc00013a1a0, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x65 fp=0xc000327858 sp=0xc0003276f8 pc=0x84c025 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).reader(0xc00013a1a0, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0x10f fp=0xc000327948 sp=0xc000327858 pc=0x84d4af Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).Reader(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).Read(0xc0002e0468?, {0xe0b1f0?, 0x1483020?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x1e fp=0xc000327978 sp=0xc000327948 pc=0x84b67e Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*ConcreteApiServer).serve.func17({0xe0a310, 0xc00036c2d0}, 0xc00030b230?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/cmd/daemon/api_server.go:636 +0x3ac fp=0xc000327a68 sp=0xc000327978 pc=0xa2640c Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.HandlerFunc.ServeHTTP(0xc00009e000?, {0xe0a310?, 0xc00036c2d0?}, 0x2000000000000?) Jan 26 11:52:16 volumio-pc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Jan 26 11:52:16 volumio-pc volumio[1033]: info: Connection to go-librespot Websocket closed Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc000327a90 sp=0xc000327a68 pc=0x70f109 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*ServeMux).ServeHTTP(0xc0000a21a0?, {0xe0a310, 0xc00036c2d0}, 0xc0004fa500) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2861 +0x1c7 fp=0xc000327ae0 sp=0xc000327a90 pc=0x710fe7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xe0a310, 0xc00036c2d0}, 0xc0004fa500) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x164 fp=0xc000327b38 sp=0xc000327ae0 pc=0xa25e84 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.HandlerFunc.ServeHTTP(0x485cb9?, {0xe0a310?, 0xc00036c2d0?}, 0xc000506b68?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc000327b60 sp=0xc000327b38 pc=0x70f109 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.serverHandler.ServeHTTP({0xc000144240?}, {0xe0a310?, 0xc00036c2d0?}, 0x1?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:3340 +0x8e fp=0xc000327b90 sp=0xc000327b60 pc=0x72e58e Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*conn).serve(0xc00001a1b0, {0xe0b260, 0xc0000364e0}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:2109 +0x665 fp=0xc000327fb8 sp=0xc000327b90 pc=0x70d205 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Server).Serve.gowrap3() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:3493 +0x28 fp=0xc000327fe0 sp=0xc000327fb8 pc=0x712e08 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000327fe8 sp=0xc000327fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by net/http.(*Server).Serve in goroutine 23 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/server.go:3493 +0x485 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 32 gp=0xc0004861c0 m=nil [select]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00032aec0?, 0x2?, 0xc0?, 0x61?, 0xc00032adf4?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00032ac78 sp=0xc00032ac58 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc00032aec0, 0xc00032adf0, 0x19?, 0x0, 0x416e00?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00032adb8 sp=0xc00032ac78 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).getConn(0x14090e0, 0xc000422870, {{}, 0x0, {0xcf7e79, 0x5}, {0xc00012c2c0, 0x19}, 0x0}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:1523 +0x4ad fp=0xc00032af90 sp=0xc00032adb8 pc=0x722cad Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).roundTrip(0x14090e0, 0xc0001488c0) Jan 26 11:52:16 volumio-pc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:685 +0xa54 fp=0xc00032b170 sp=0xc00032af90 pc=0x71e9b4 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Transport).RoundTrip(0xc0001488c0?, 0xe02500?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/roundtrip.go:33 +0x18 fp=0xc00032b190 sp=0xc00032b170 pc=0x72dcd8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.send(0xc000148780, {0xe02500, 0x14090e0}, {0xc00032b301?, 0x4b9773?, 0x1461860?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/client.go:259 +0x5e2 fp=0xc00032b380 sp=0xc00032b190 pc=0x6c1da2 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Client).send(0xc0002e3b30, 0xc000148780, {0x7f95ab522a78?, 0x10?, 0x1461860?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/client.go:180 +0x91 fp=0xc00032b3f8 sp=0xc00032b380 pc=0x6c1651 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Client).do(0xc0002e3b30, 0xc000148780) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/client.go:729 +0x9c9 fp=0xc00032b5e8 sp=0xc00032b3f8 pc=0x6c3b69 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*Client).Do(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/client.go:587 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).fetchUrls(0xc0001f02d0, {0xe0b308, 0xc000490af0}, {0xc00032ba60, 0x1, 0x4c6b0f?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/apresolve/resolve.go:83 +0x673 fp=0xc00032b9e0 sp=0xc00032b5e8 pc=0x926f33 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).get(0xc0001f02d0, {0xe0b308?, 0xc000490af0?}, {0xce7e94, 0xb}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/apresolve/resolve.go:126 +0x8b fp=0xc00032ba88 sp=0xc00032b9e0 pc=0x927a2b Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/apresolve.(*ApResolver).getFunc.func1({0xe0b308?, 0xc000490af0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/apresolve/resolve.go:157 +0x8f fp=0xc00032bb08 sp=0xc00032ba88 pc=0x927ecf Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).init(0xc00036c0f0, {0xe0b228, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:94 +0x21a fp=0xc00032bbe0 sp=0xc00032bb08 pc=0x8a3e3a Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).connect(0xc00036c0f0, {0xe0b228, 0x1483020}, 0xc000422320) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:205 +0xc8 fp=0xc00032bc58 sp=0xc00032bbe0 pc=0x8a4f48 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect(0xc00036c0f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:394 +0xc7 fp=0xc00032bca8 sp=0xc00032bc58 pc=0x8a6527 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect-fm() Jan 26 11:52:16 volumio-pc go-librespot[1912]: :1 +0x25 fp=0xc00032bcc0 sp=0xc00032bca8 pc=0x8aa185 Jan 26 11:52:16 volumio-pc systemd[1]: go-librespot-daemon.service: Consumed 3.866s CPU time. Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer.Operation.withEmptyData.func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:18 +0x13 fp=0xc00032bcd0 sp=0xc00032bcc0 pc=0x899b73 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0xc00032bdf8?, {0xe08da8, 0xc000392e40}, 0x0, {0x0, 0x0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:88 +0x11c fp=0xc00032bdc0 sp=0xc00032bcd0 pc=0x899f5c Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/cenkalti/backoff/v4.RetryNotifyWithTimer(0x0?, {0xe08da8?, 0xc000392e40?}, 0x0?, {0x0?, 0x0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:61 +0x56 fp=0xc00032be18 sp=0xc00032bdc0 pc=0x899af6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/cenkalti/backoff/v4.RetryNotify(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:49 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/cenkalti/backoff/v4.Retry(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/github.com/cenkalti/backoff/v4@v4.3.0/retry.go:38 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0xc00036c0f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:335 +0x451 fp=0xc00032bfc8 sp=0xc00032be18 pc=0x8a5df1 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:273 +0x25 fp=0xc00032bfe0 sp=0xc00032bfc8 pc=0x8a5965 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00032bfe8 sp=0xc00032bfe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 42 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/ap/ap.go:273 +0x78 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 31 gp=0xc000486380 m=nil [runnable]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc000505f40?, 0x5?, 0x5?, 0x0?, 0xc000505ee6?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000505d68 sp=0xc000505d48 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc000505f40, 0xc000505edc, 0x0?, 0x0, 0x5?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000505ea8 sp=0xc000505d68 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc00013a000) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc000505fc8 sp=0xc000505ea8 pc=0x847556 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.newConn.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc000505fe0 sp=0xc000505fc8 pc=0x847165 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000505fe8 sp=0xc000505fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by nhooyr.io/websocket.newConn in goroutine 42 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 82 gp=0xc000102700 m=nil [IO wait]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc00004ace0?, 0xc0004a5500?, 0x25?, 0x4f?, 0xb?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004a5460 sp=0xc0004a5440 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0004a5498 sp=0xc0004a5460 pc=0x44d977 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.runtime_pollWait(0x7f95617fec00, 0x72) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0004a54b8 sp=0xc0004a5498 pc=0x4880e5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).wait(0xc00043f000?, 0xc0003a1000?, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0004a54e0 sp=0xc0004a54b8 pc=0x50a827 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*pollDesc).waitRead(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jan 26 11:52:16 volumio-pc go-librespot[1912]: internal/poll.(*FD).Read(0xc00043f000, {0xc0003a1000, 0x1000, 0x1000}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0004a5578 sp=0xc0004a54e0 pc=0x50bb19 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*netFD).Read(0xc00043f000, {0xc0003a1000?, 0xc0004a5668?, 0x526f75?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0004a55c0 sp=0xc0004a5578 pc=0x57a5a5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.(*conn).Read(0xc000060138, {0xc0003a1000?, 0x7f9563128680?, 0x7f95ab522108?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0004a5608 sp=0xc0004a55c0 pc=0x588ac5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/tls.(*atLeastReader).Read(0xc000472438, {0xc0003a1000?, 0xb40ac0?, 0xc0004a5750?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0004a5650 sp=0xc0004a5608 pc=0x63f87b Jan 26 11:52:16 volumio-pc go-librespot[1912]: bytes.(*Buffer).ReadFrom(0xc0005262a8, {0xe03f40, 0xc000472438}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0004a56a8 sp=0xc0004a5650 pc=0x534958 Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/tls.(*Conn).readFromUntil(0xc000526008, {0xe01ea0, 0xc000060138}, 0x450db4?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0004a56e0 sp=0xc0004a56a8 pc=0x63fa5e Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/tls.(*Conn).readRecordOrCCS(0xc000526008, 0x0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc0004a5958 sp=0xc0004a56e0 pc=0x63cadb Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/tls.(*Conn).readRecord(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/tls/conn.go:589 Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/tls.(*Conn).Read(0xc000526008, {0xc000138000, 0x1000, 0x0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc0004a59c0 sp=0xc0004a5958 pc=0x643385 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net/http.(*readWriteCloserBody).Read(0x1?, {0xc000138000?, 0xffffffffffffffff?, 0x48944e?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/http/transport.go:2578 +0x88 fp=0xc0004a59f0 sp=0xc0004a59c0 pc=0x7297e8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: bufio.(*Reader).fill(0xc0001aa7e0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc0004a5a28 sp=0xc0004a59f0 pc=0x68e1c3 Jan 26 11:52:16 volumio-pc go-librespot[1912]: bufio.(*Reader).ReadByte(0xc0001aa7e0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/bufio/bufio.go:273 +0x27 fp=0xc0004a5a48 sp=0xc0004a5a28 pc=0x68e8e7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.readFrameHeader(0xc0001aa7e0, {0xc00013a068, 0x8, 0x8}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x85 fp=0xc0004a5ad8 sp=0xc0004a5a48 pc=0x84aa65 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).readFrameHeader(0xc00013a000, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xd6 fp=0xc0004a5c18 sp=0xc0004a5ad8 pc=0x84c6b6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).readLoop(0xc00013a000, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x65 fp=0xc0004a5d78 sp=0xc0004a5c18 pc=0x84c025 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).reader(0xc00013a000, {0xe0b1f0, 0x1483020}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0x10f fp=0xc0004a5e68 sp=0xc0004a5d78 pc=0x84d4af Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).Reader(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).Read(0xc0000f2200?, {0xe0b1f0?, 0x1483020?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x1e fp=0xc0004a5e98 sp=0xc0004a5e68 pc=0x84b67e Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0xc0004840e0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:188 +0x67 fp=0xc0004a5fc8 sp=0xc0004a5e98 pc=0x92e987 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:125 +0x25 fp=0xc0004a5fe0 sp=0xc0004a5fc8 pc=0x92e505 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004a5fe8 sp=0xc0004a5fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 42 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:125 +0x78 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 83 gp=0xc0001028c0 m=nil [runnable]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: errors.Is({0x0?, 0x0?}, {0xe01da0?, 0xdfd870?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/errors/wrap.go:44 +0xb4 fp=0xc000073b48 sp=0xc000073b40 pc=0x498c14 Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/internal/sysrand.read({0xc00013a120?, 0x422d1e?, 0x1?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/internal/sysrand/rand_getrandom.go:47 +0x7d fp=0xc000073ba8 sp=0xc000073b48 pc=0x5a2bfd Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/internal/sysrand.Read({0xc00013a120?, 0xc0001101c0?, 0xc0001102a0?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/internal/sysrand/rand.go:41 +0xa5 fp=0xc000073c08 sp=0xc000073ba8 pc=0x5a2925 Jan 26 11:52:16 volumio-pc go-librespot[1912]: crypto/rand.(*reader).Read(0x468980?, {0xc00013a120, 0x4, 0x8}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/crypto/rand/rand.go:50 +0x65 fp=0xc000073c30 sp=0xc000073c08 pc=0x5e3ec5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: io.ReadAtLeast({0xe02e60, 0xc0001a04f0}, {0xc00013a120, 0x4, 0x8}, 0x4) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc000073c78 sp=0xc000073c30 pc=0x4c8bae Jan 26 11:52:16 volumio-pc go-librespot[1912]: io.ReadFull(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/io/io.go:354 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).writeFrame(0xc00013a000, {0xe0b308, 0xc0001ecfc0}, 0x1, 0x0, 0x1, {0xc0005902e0, 0xf, 0xf}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/write.go:281 +0x247 fp=0xc000073e10 sp=0xc000073c78 pc=0x850067 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).write(0xc00013a000, {0xe0b308, 0xc0001ecfc0}, 0x1483020?, {0xc0005902e0, 0xf, 0xf}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/write.go:116 +0x1be fp=0xc000073eb0 sp=0xc000073e10 pc=0x84eede Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).Write(0xe0b1f0?, {0xe0b308?, 0xc0001ecfc0?}, 0x0?, {0xc0005902e0?, 0x1?, 0xf?}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/write.go:49 +0x25 fp=0xc000073f08 sp=0xc000073eb0 pc=0x84eb65 Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0xc0004840e0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:156 +0x2bf fp=0xc000073fc8 sp=0xc000073f08 pc=0x92e7ff Jan 26 11:52:16 volumio-pc go-librespot[1912]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap2() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:129 +0x25 fp=0xc000073fe0 sp=0xc000073fc8 pc=0x92e4a5 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000073fe8 sp=0xc000073fe0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 42 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/dealer/dealer.go:129 +0xf6 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 118 gp=0xc000102a80 m=nil [select, 862 minutes]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.gopark(0xc0000c2740?, 0x5?, 0x89?, 0x6e?, 0xc0000c26e6?) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0000c2568 sp=0xc0000c2548 pc=0x488f0e Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.selectgo(0xc0000c2740, 0xc0000c26dc, 0x486405?, 0x0, 0xaf6301?, 0x1) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0000c26a8 sp=0xc0000c2568 pc=0x467bd7 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc00013a1a0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc0000c27c8 sp=0xc0000c26a8 pc=0x847556 Jan 26 11:52:16 volumio-pc go-librespot[1912]: nhooyr.io/websocket.newConn.gowrap1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc0000c27e0 sp=0xc0000c27c8 pc=0x847165 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000c27e8 sp=0xc0000c27e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by nhooyr.io/websocket.newConn in goroutine 116 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Jan 26 11:52:16 volumio-pc go-librespot[1912]: goroutine 91 gp=0xc000102fc0 m=6 mp=0xc000094008 [syscall]: Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.cgocall(0xaa3d00, 0xc00005e600) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/cgocall.go:167 +0x4b fp=0xc00005e5d8 sp=0xc00005e5a0 pc=0x485deb Jan 26 11:52:16 volumio-pc go-librespot[1912]: net._C2func_getaddrinfo(0xc00003a1f8, 0x0, 0xc000301230, 0xc0000600f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: _cgo_gotypes.go:109 +0x50 fp=0xc00005e600 sp=0xc00005e5d8 pc=0x598af0 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net._C_getaddrinfo.func1(...) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix_cgo.go:84 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net._C_getaddrinfo(0xc00003a1f8, 0x0, 0xc000301230, 0xc0000600f0) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix_cgo.go:84 +0x7b fp=0xc00005e648 sp=0xc00005e600 pc=0x598e1b Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.cgoLookupHostIP({0xce44e8, 0x3}, {0xc00012c2c0, 0x15}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:174 +0x1fd fp=0xc00005e750 sp=0xc00005e648 pc=0x56d85d Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.cgoLookupIP.func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:229 +0x25 fp=0xc00005e780 sp=0xc00005e750 pc=0x56df05 Jan 26 11:52:16 volumio-pc go-librespot[1912]: net.doBlockingWithCtx[...].func1() Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:67 +0x56 fp=0xc00005e7e0 sp=0xc00005e780 pc=0x59bd96 Jan 26 11:52:16 volumio-pc go-librespot[1912]: runtime.goexit({}) Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005e7e8 sp=0xc00005e7e0 pc=0x490a41 Jan 26 11:52:16 volumio-pc go-librespot[1912]: created by net.doBlockingWithCtx[...] in goroutine 90 Jan 26 11:52:16 volumio-pc go-librespot[1912]: /usr/local/go/src/net/cgo_unix.go:64 +0x210 Jan 26 11:52:16 volumio-pc go-librespot[1911]: Aborted Jan 26 11:52:17 volumio-pc volumiossh-tunnel[142984]: ssh: Could not resolve hostname eu6.myvolumio.org: Device or resource busy Jan 26 11:52:17 volumio-pc autossh[2189]: ssh exited with error status 255; restarting ssh Jan 26 11:52:17 volumio-pc autossh[2189]: starting ssh (count 16) Jan 26 11:52:17 volumio-pc autossh[2189]: ssh child pid is 143018 Jan 26 11:52:19 volumio-pc volumio[1033]: info: Initializing connection to go-librespot Websocket Jan 26 11:52:20 volumio-pc systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Jan 26 11:52:20 volumio-pc systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Jan 26 11:52:20 volumio-pc systemd[1]: go-librespot-daemon.service: Consumed 3.866s CPU time. Jan 26 11:52:20 volumio-pc systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Jan 26 11:52:20 volumio-pc go-librespot[143022]: go-librespot daemon starting... Jan 26 11:52:20 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:20+02:00" level=info msg="running go-librespot 0.6.2" Jan 26 11:52:20 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:20+02:00" level=debug msg="app state loaded" Jan 26 11:52:20 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:20+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jan 26 11:52:23 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:23+02:00" level=debug msg="new websocket client" Jan 26 11:52:23 volumio-pc volumio[1033]: info: Connection to go-librespot Websocket established Jan 26 11:52:24 volumio-pc systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 26 11:52:24 volumio-pc systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 26 11:52:24 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:24+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Jan 26 11:52:24 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:24+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jan 26 11:52:24 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:24+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jan 26 11:52:24 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:24+02:00" level=info msg="zeroconf server listening on port 44941" Jan 26 11:52:26 volumio-pc volumio[1033]: info: Getting Spotify volume Jan 26 11:52:26 volumio-pc volumio[1033]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jan 26 11:52:26 volumio-pc volumio[1033]: info: CoreCommandRouter::volumioGetState Jan 26 11:52:54 volumio-pc go-librespot[143023]: time="2026-01-26T11:52:54+02:00" level=fatal msg="failed running with username and spotify token" error="failed obtaining client token: failed requesting clienttoken: Post \"https://clienttoken.spotify.com/v1/clienttoken\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" Jan 26 11:52:54 volumio-pc systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jan 26 11:52:54 volumio-pc systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jan 26 11:52:54 volumio-pc volumio[1033]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 11:52:54 volumio-pc volumio[1033]: Error: socket hang up Jan 26 11:52:54 volumio-pc volumio[1033]: at connResetException (node:internal/errors:720:14) Jan 26 11:52:54 volumio-pc volumio[1033]: at Socket.socketOnEnd (node:_http_client:519:23) Jan 26 11:52:54 volumio-pc volumio[1033]: at Socket.emit (node:events:526:35) Jan 26 11:52:54 volumio-pc volumio[1033]: at endReadableNT (node:internal/streams/readable:1376:12) Jan 26 11:52:54 volumio-pc volumio[1033]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Jan 26 11:52:54 volumio-pc volumio[1033]: code: 'ECONNRESET', Jan 26 11:52:54 volumio-pc volumio[1033]: response: undefined Jan 26 11:52:54 volumio-pc volumio[1033]: } Jan 26 11:52:54 volumio-pc volumio[1033]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 11:52:54 volumio-pc sudo[143156]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-26 11:51' Jan 26 11:52:54 volumio-pc sudo[143156]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"