Updated to Volumio 3.742 with same Spotify 4.1.0. I was having the following issues with prior versions and ran into two instances of a go-librespot crash:
- Songs that won’t play on Volumio but play on Spotify iOS and Mac (potentially same/similar issue to sciensys earlier)
- Issues with Spotify queue clearing/disappearing when playing on Volumio (see consistent repro below)
While trying to create a repro for the Spotify queue issue with Volumio, I ran into the crash below twice. Here is a consistent repro for Spotify queue issues with Volumio:
- Play a playlist on Volumio from iOS (confirmed OS and Spotify on latest)
- Add a few songs to queue while playlist is playing
- On iOS Spotify app attempt to change the order of your queue
Expected: Queue order adjusts without dropping songs (confirmed this works as expected with an Amazon Echo device)
Actual: Every time you change the order of a song in queue a song is dropped from the Spotify queue. This is typically but not always the top-most song
While checking consistency of repro above I hit the following crash twice which I’m guessing is a timing issue with the queue going empty just before it is about to play a song from the queue. Once it hits this crash, Volumio was unable to recover and required not only a shutdown but full disconnect from power (simple restart persisted I2C errors):
Aug 17 13:48:55 justin-volumio go-librespot[1095]: time="2024-08-17T13:48:55-07:00" level=debug msg="sending successful reply for dealer request"
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6Owc2SuzwO3LW1SAODYK3l","name":"Melody","artist_names":["Sigala"],"album_name":"Melody","album_cover_url":"https://i.scdn.co/image/ab67616d00001e0201649797af71d97b8f53ebf3","position":0,"duration":167142,"release_date":"year:2022 month:1 day:21","track_number":1,"disc_number":1}}
Aug 17 13:48:55 justin-volumio go-librespot[1095]: time="2024-08-17T13:48:55-07:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:6Owc2SuzwO3LW1SAODYK3l"
Aug 17 13:48:55 justin-volumio go-librespot[1095]: time="2024-08-17T13:48:55-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 17 13:48:55 justin-volumio go-librespot[1095]: time="2024-08-17T13:48:55-07:00" level=trace msg="emitting websocket event: playing"
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6Owc2SuzwO3LW1SAODYK3l","play_origin":"playlist"}}
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: PUSH STATE SPOTIFY
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: {"status":"play","service":"spop","title":"Melody","artist":"Sigala","album":"Melody","albumart":"https://i.scdn.co/image/ab67616d00001e0201649797af71d97b8f53ebf3","uri":"spotify:track:6Owc2SuzwO3LW1SAODYK3l","trackType":"spotify","seek":0,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":false,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::servicePushState
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreStateMachine::pushState
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::volumioPushState
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: PUSH STATE SPOTIFY
Aug 17 13:48:55 justin-volumio volumio[911]: SPOTIFY: {"status":"play","service":"spop","title":"Melody","artist":"Sigala","album":"Melody","albumart":"https://i.scdn.co/image/ab67616d00001e0201649797af71d97b8f53ebf3","uri":"spotify:track:6Owc2SuzwO3LW1SAODYK3l","trackType":"spotify","seek":1000,"duration":167,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":false,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::servicePushState
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreStateMachine::pushState
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 17 13:48:55 justin-volumio volumio[911]: info: CoreCommandRouter::volumioPushState
Aug 17 13:49:07 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:07-07:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:6Owc2SuzwO3LW1SAODYK3l"
Aug 17 13:49:08 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:08-07:00" level=debug msg="handling add_to_queue player command from 9eda0ba692653833edff1c733595c03d39826acc"
Aug 17 13:49:08 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:08-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 17 13:49:08 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:08-07:00" level=trace msg="scheduling prefetch in 123s"
Aug 17 13:49:08 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:08-07:00" level=debug msg="sending successful reply for dealer request"
Aug 17 13:49:13 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:13-07:00" level=debug msg="handling set_queue player command from ce34ae43b66d247156df6dcec20bb4173c7f5ad0"
Aug 17 13:49:13 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:13-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Aug 17 13:49:13 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:13-07:00" level=trace msg="scheduling prefetch in 118s"
Aug 17 13:49:13 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:13-07:00" level=debug msg="sending successful reply for dealer request"
Aug 17 13:49:18 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:18-07:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:6Owc2SuzwO3LW1SAODYK3l"
Aug 17 13:49:21 justin-volumio go-librespot[1095]: time="2024-08-17T13:49:21-07:00" level=debug msg="handling skip_next player command from ce34ae43b66d247156df6dcec20bb4173c7f5ad0"
Aug 17 13:49:21 justin-volumio go-librespot[1095]: panic: runtime error: slice bounds out of range [1:0]
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 204 gp=0x1209328 m=8 mp=0x1080588 [running]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: panic({0x623058, 0x1756240})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/panic.go:779 +0x12c fp=0x151b530 sp=0x151b4dc pc=0x58364
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goPanicSliceB(0x1, 0x0)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/panic.go:154 +0xa4 fp=0x151b550 sp=0x151b530 pc=0x5717c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: go-librespot/tracks.(*List).GoNext(0x128a150)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/tracks/tracks.go:177 +0x1c0 fp=0x151b578 sp=0x151b550 pc=0x4ac290
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*AppPlayer).advanceNext(0x1112e10, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/controls.go:460 +0x60 fp=0x151b668 sp=0x151b578 pc=0x5763b8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*AppPlayer).skipNext(0x1112e10)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/controls.go:433 +0x24 fp=0x151b6a4 sp=0x151b668 pc=0x5761f8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*AppPlayer).handlePlayerCommand(0x1112e10, {0x621a1565, {0x0, 0x0}, {0x12ac060, 0x28}, {{0x1756220, 0x9}, {0x0, 0x0}, ...}})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:257 +0x624 fp=0x151b7c4 sp=0x151b6a4 pc=0x57b4d8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*AppPlayer).handleDealerRequest(0x1112e10, {0x115e000, {0x12ac000, 0x24}, {0x621a1565, {0x0, 0x0}, {0x12ac060, 0x28}, {{0x1756220, ...}, ...}}})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:303 +0xe4 fp=0x151b8fc sp=0x151b7c4 pc=0x57cbb0
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*AppPlayer).Run(0x1112e10, 0x1076f80)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:442 +0x3d8 fp=0x151bfe0 sp=0x151b8fc pc=0x57df84
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*App).withAppPlayer.func3.gowrap1()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:321 +0x30 fp=0x151bfec sp=0x151bfe0 pc=0x578d60
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x151bfec sp=0x151bfec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by main.(*App).withAppPlayer.func3 in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:321 +0x2f8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 1 gp=0x1002128 m=nil [select, 12 minutes]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1285d68 sp=0x1285d54 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.selectgo(0x1285e68, 0x10b7e34, 0x0, 0x0, 0x2, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x1285e08 sp=0x1285d68 pc=0x705e4
Aug 17 13:49:21 justin-volumio go-librespot[1095]: go-librespot/zeroconf.(*Zeroconf).Serve(0x130c0a0, 0x1285ee4)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/zeroconf/zeroconf.go:268 +0x228 fp=0x1285eac sp=0x1285e08 pc=0x528ad8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*App).withAppPlayer(0x111e180, 0x68f0d4)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:297 +0x4b0 fp=0x1285f1c sp=0x1285eac pc=0x578904
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*App).Zeroconf(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:127
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.main()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:458 +0x78c fp=0x1285fa8 sp=0x1285f1c pc=0x57a180
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.main()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:271 +0x2fc fp=0x1285fec sp=0x1285fa8 pc=0x5c29c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1285fec sp=0x1285fec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 18 gp=0x1084248 m=nil [force gc (idle), 15 minutes]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f740, 0xaa84c0, 0x11, 0xa, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x103e7d4 sp=0x103e7c0 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goparkunlock(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.forcegchelper()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:326 +0xe4 fp=0x103e7ec sp=0x103e7d4 pc=0x5c668
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x103e7ec sp=0x103e7ec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by runtime.init.5 in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:314 +0x1c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 19 gp=0x1084368 m=nil [GC sweep wait]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f740, 0xaa8a10, 0xc, 0x9, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x103efc4 sp=0x103efb0 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goparkunlock(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.bgsweep(0x1092000)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcsweep.go:318 +0x11c fp=0x103efe4 sp=0x103efc4 pc=0x4506c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gcenable.gowrap1()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:203 +0x28 fp=0x103efec sp=0x103efe4 pc=0x3518c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x103efec sp=0x103efec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by runtime.gcenable in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:203 +0x74
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 20 gp=0x1084488 m=nil [GC scavenge wait]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f740, 0xaa9020, 0xd, 0xa, 0x2)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x103f7b4 sp=0x103f7a0 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goparkunlock(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.(*scavengerState).park(0xaa9020)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcscavenge.go:425 +0x68 fp=0x103f7c8 sp=0x103f7b4 pc=0x4238c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.bgscavenge(0x1092000)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcscavenge.go:658 +0x60 fp=0x103f7e4 sp=0x103f7c8 pc=0x42ac4
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gcenable.gowrap2()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:204 +0x28 fp=0x103f7ec sp=0x103f7e4 pc=0x35138
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x103f7ec sp=0x103f7ec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by runtime.gcenable in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:204 +0xbc
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 2 gp=0x1002c68 m=nil [finalizer wait]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f5ec, 0xad3bac, 0x10, 0xa, 0x1)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1042f8c sp=0x1042f78 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.runfinq()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mfinal.go:194 +0x110 fp=0x1042fec sp=0x1042f8c pc=0x33f78
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1042fec sp=0x1042fec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by runtime.createfing in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mfinal.go:164 +0x5c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 34 gp=0x1106488 m=nil [IO wait, 15 minutes]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f730, 0x7606ded8, 0x2, 0x2, 0x5)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x117a5dc sp=0x117a5c8 pc=0x5c82c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.netpollblock(0x7606dec8, 0x72, 0x0)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x117a5f4 sp=0x117a5dc pc=0x540f0
Aug 17 13:49:21 justin-volumio go-librespot[1095]: internal/poll.runtime_pollWait(0x7606dec8, 0x72)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x117a608 sp=0x117a5f4 pc=0x8eba8
Aug 17 13:49:21 justin-volumio go-librespot[1095]: internal/poll.(*pollDesc).wait(0x1112ba8, 0x72, 0x0)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x117a61c sp=0x117a608 pc=0x108108
Aug 17 13:49:21 justin-volumio go-librespot[1095]: internal/poll.(*pollDesc).waitRead(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89
Aug 17 13:49:21 justin-volumio go-librespot[1095]: internal/poll.(*FD).Accept(0x1112b90)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:611 +0x294 fp=0x117a664 sp=0x117a61c pc=0x10c974
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net.(*netFD).accept(0x1112b90)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_unix.go:172 +0x20 fp=0x117a6cc sp=0x117a664 pc=0x2a24f4
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net.(*TCPListener).accept(0x112a270)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock_posix.go:159 +0x20 fp=0x117a6e4 sp=0x117a6cc pc=0x2ba5f4
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net.(*TCPListener).Accept(0x112a270)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock.go:327 +0x30 fp=0x117a700 sp=0x117a6e4 pc=0x2b9660
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net/http.(*onceCloseListener).Accept(0x1073560)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: :1 +0x34 fp=0x117a718 sp=0x117a700 pc=0x45e904
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net/http.(*Server).Serve(0x1193408, {0x724fbc, 0x112a270})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3255 +0x314 fp=0x117a7b0 sp=0x117a718 pc=0x43cfc0
Aug 17 13:49:21 justin-volumio go-librespot[1095]: net/http.Serve(...)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2794
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.(*ApiServer).serve(0x112ed00)
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:470 +0x5ec fp=0x117a7e4 sp=0x117a7b0 pc=0x5706a4
Aug 17 13:49:21 justin-volumio go-librespot[1095]: main.NewApiServer.gowrap1()
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:240 +0x28 fp=0x117a7ec sp=0x117a7e4 pc=0x56fd78
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.goexit({})
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x117a7ec sp=0x117a7ec pc=0x9346c
Aug 17 13:49:21 justin-volumio go-librespot[1095]: created by main.NewApiServer in goroutine 1
Aug 17 13:49:21 justin-volumio go-librespot[1095]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:240 +0x224
Aug 17 13:49:21 justin-volumio go-librespot[1095]: goroutine 41 gp=0x11066c8 m=nil [GC worker (idle)]:
Aug 17 13:49:21 justin-volumio go-librespot[1095]: runtime.gopark(0x68f5fc, 0x1029cc8, 0x1a, 0xa, 0x0)