-- Logs begin at Thu 2019-02-14 10:12:06 GMT, end at Sat 2025-02-22 14:11:20 GMT. -- Feb 22 14:11:04 robs-hifi ntpd[671]: receive: Unexpected origin timestamp 0xeb40b1e7.b1f367f3 does not match aorg 0000000000.00000000 from server@85.199.214.101 xmt 0xeb645978.0414f2b5 Feb 22 14:11:04 robs-hifi ntpd[671]: receive: Unexpected origin timestamp 0xeb40b1e7.b19c0102 does not match aorg 0000000000.00000000 from server@131.111.8.63 xmt 0xeb645978.0436690e Feb 22 14:11:04 robs-hifi ntpd[671]: receive: Unexpected origin timestamp 0xeb40b1e7.b2051026 does not match aorg 0000000000.00000000 from server@131.111.8.61 xmt 0xeb645978.04877676 Feb 22 14:11:04 robs-hifi ntpd[671]: receive: Unexpected origin timestamp 0xeb40b1e7.b1e15f90 does not match aorg 0000000000.00000000 from server@129.250.35.250 xmt 0xeb645978.0ce09e6d Feb 22 14:11:04 robs-hifi systemd[1]: Starting Daily apt download activities... Feb 22 14:11:04 robs-hifi go-librespot[968]: time="2025-02-22T14:11:04Z" level=debug msg="put connect state because NEW_DEVICE" Feb 22 14:11:04 robs-hifi go-librespot[968]: time="2025-02-22T14:11:04Z" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 22 14:11:04 robs-hifi go-librespot[968]: time="2025-02-22T14:11:04Z" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 22 14:11:04 robs-hifi go-librespot[968]: time="2025-02-22T14:11:04Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 22 14:11:04 robs-hifi go-librespot[968]: time="2025-02-22T14:11:04Z" level=debug msg="autoplay enabled: false" Feb 22 14:11:04 robs-hifi sudo[988]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 14:11:04 robs-hifi sudo[988]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 14:11:05 robs-hifi sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 14:11:05 robs-hifi sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 14:11:05 robs-hifi volumio[798]: info: CoreCommandRouter::volumioGetState Feb 22 14:11:05 robs-hifi sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 14:11:05 robs-hifi volumio[798]: info: CorePlayQueue::getTrack 0 Feb 22 14:11:05 robs-hifi sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=debug msg="handling transfer player command from ea3b6c8ff411cc894ea17b42e77dbbf07698dd57" Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=debug msg="resolved context of track" uri="spotify:playlist:37i9dQZF1E4nbpIoUnKw7I" Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:playlist:37i9dQZF1E4nbpIoUnKw7I" Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=debug msg="loading track (paused: false, position: 217843ms)" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 22 14:11:05 robs-hifi go-librespot[968]: time="2025-02-22T14:11:05Z" level=trace msg="emitting websocket event: will_play" Feb 22 14:11:06 robs-hifi go-librespot[968]: time="2025-02-22T14:11:06Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Feb 22 14:11:06 robs-hifi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 22 14:11:06 robs-hifi go-librespot[968]: time="2025-02-22T14:11:06Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1664" Feb 22 14:11:06 robs-hifi systemd[1]: shairport-sync.service: Succeeded. Feb 22 14:11:06 robs-hifi go-librespot[968]: time="2025-02-22T14:11:06Z" level=debug msg="selected format OGG_VORBIS_320 (b34edc530c417cfc216558e036b0e14ca10f49ce)" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:06 robs-hifi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 22 14:11:06 robs-hifi go-librespot[968]: time="2025-02-22T14:11:06Z" level=debug msg="requested aes key for file b34edc530c417cfc216558e036b0e14ca10f49ce, gid: 6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:06 robs-hifi go-librespot[968]: time="2025-02-22T14:11:06Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1277" Feb 22 14:11:06 robs-hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 22 14:11:06 robs-hifi sudo[988]: pam_unix(sudo:session): session closed for user root Feb 22 14:11:06 robs-hifi sudo[990]: pam_unix(sudo:session): session closed for user root Feb 22 14:11:06 robs-hifi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 22 14:11:07 robs-hifi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 22 14:11:07 robs-hifi systemd[1]: shairport-sync.service: Succeeded. Feb 22 14:11:07 robs-hifi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 22 14:11:07 robs-hifi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 22 14:11:07 robs-hifi sudo[997]: pam_unix(sudo:session): session closed for user root Feb 22 14:11:07 robs-hifi volumio[798]: info: go-librespot daemon successfully initialized Feb 22 14:11:07 robs-hifi volumio[798]: info: Discovery: A device disappeared from network Feb 22 14:11:07 robs-hifi volumio[798]: info: Discovery: Device robs-hifi disappeared from network Feb 22 14:11:08 robs-hifi volumio[798]: info: Shairport-Sync Started Feb 22 14:11:08 robs-hifi volumio[798]: Error adding Membership: Error: addMembership EINVAL Feb 22 14:11:08 robs-hifi volumio[798]: info: Shairport-Sync Started Feb 22 14:11:08 robs-hifi volumio[798]: info: Shairport-Sync Started Feb 22 14:11:08 robs-hifi go-librespot[968]: time="2025-02-22T14:11:08Z" level=debug msg="fetched first chunk of 16, total size is 8177768 bytes" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:08 robs-hifi volumio[798]: info: Discovery: adding e3087944-e060-442f-8352-217669d660ed Feb 22 14:11:08 robs-hifi volumio[798]: info: Discovery: Found device robs-hifi Feb 22 14:11:08 robs-hifi volumio[798]: info: CoreCommandRouter::volumioGetState Feb 22 14:11:08 robs-hifi volumio[798]: info: CorePlayQueue::getTrack 0 Feb 22 14:11:10 robs-hifi go-librespot[968]: time="2025-02-22T14:11:10Z" level=debug msg="fetched chunk 3/15, size: 524288" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:10 robs-hifi volumio[798]: info: Initializing connection to go-librespot Websocket Feb 22 14:11:10 robs-hifi go-librespot[968]: time="2025-02-22T14:11:10Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 250" Feb 22 14:11:10 robs-hifi go-librespot[968]: time="2025-02-22T14:11:10Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1635" Feb 22 14:11:10 robs-hifi go-librespot[968]: time="2025-02-22T14:11:10Z" level=debug msg="new websocket client" Feb 22 14:11:11 robs-hifi volumio[798]: info: Connection to go-librespot Websocket established Feb 22 14:11:11 robs-hifi go-librespot[968]: time="2025-02-22T14:11:11Z" level=debug msg="fetched chunk 15/15, size: 313448" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:11 robs-hifi go-librespot[968]: time="2025-02-22T14:11:11Z" level=trace msg="seek to 217843ms (diff: 126ms, samples: 9606876, bytes: 8107494)" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:11 robs-hifi go-librespot[968]: time="2025-02-22T14:11:11Z" level=debug msg="fetched chunk 1/15, size: 524288" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:11 robs-hifi go-librespot[968]: time="2025-02-22T14:11:11Z" level=debug msg="fetched chunk 2/15, size: 524288" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5102 us, period size = 225 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 98 frames" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="created new output device" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=info msg="loaded track \"TOO COOL TO BE CARELESS\" (paused: false, position: 217843ms, duration: 220046ms, prefetched: false)" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=trace msg="emitting websocket event: metadata" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="prefetching next track" uri="spotify:track:6GOOcBV0wLoHrH5D9AWA32" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1664" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=trace msg="emitting websocket event: active" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="sending successful reply for dealer request" Feb 22 14:11:12 robs-hifi volumio[798]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6KqM3xmPIDonsTjCSGrrr5","name":"TOO COOL TO BE CARELESS","artist_names":["PAWSA"],"album_name":"TOO COOL TO BE CARELESS","album_cover_url":"https://i.scdn.co/image/ab67616d00001e022ae2ed5bc30ffd941d29d4ac","position":217843,"duration":220046,"release_date":"year:2024 month:7 day:5","track_number":1,"disc_number":1}} Feb 22 14:11:12 robs-hifi volumio[798]: SPOTIFY: received: {"type":"active","data":null} Feb 22 14:11:12 robs-hifi volumio[798]: info: Aligning Spotify Volume to Volumio Volume Feb 22 14:11:12 robs-hifi volumio[798]: info: CoreCommandRouter::volumioGetState Feb 22 14:11:12 robs-hifi volumio[798]: info: CorePlayQueue::getTrack 0 Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="selected format OGG_VORBIS_320 (8e93e61aecfef28818a921a572e46fbc3ca350c3)" uri="spotify:track:6GOOcBV0wLoHrH5D9AWA32" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="requested aes key for file 8e93e61aecfef28818a921a572e46fbc3ca350c3, gid: 6GOOcBV0wLoHrH5D9AWA32" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=trace msg="emitting websocket event: playing" Feb 22 14:11:12 robs-hifi volumio[798]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6KqM3xmPIDonsTjCSGrrr5","play_origin":"playlist/ondemand"}} Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="handling seek_to player command from ea3b6c8ff411cc894ea17b42e77dbbf07698dd57" Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="seek track to 0ms" Feb 22 14:11:12 robs-hifi volumio[798]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 14:11:12 robs-hifi go-librespot[968]: time="2025-02-22T14:11:12Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1277" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6KqM3xmPIDonsTjCSGrrr5" Feb 22 14:11:13 robs-hifi volumio[798]: TypeError: Cannot read property 'service' of undefined Feb 22 14:11:13 robs-hifi volumio[798]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) Feb 22 14:11:13 robs-hifi volumio[798]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) Feb 22 14:11:13 robs-hifi volumio[798]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) Feb 22 14:11:13 robs-hifi volumio[798]: at WebSocket.emit (events.js:315:20) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.emit (events.js:315:20) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Feb 22 14:11:13 robs-hifi volumio[798]: at writeOrBuffer (internal/streams/writable.js:358:12) Feb 22 14:11:13 robs-hifi volumio[798]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Feb 22 14:11:13 robs-hifi volumio[798]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Feb 22 14:11:13 robs-hifi volumio[798]: at Socket.emit (events.js:315:20) Feb 22 14:11:13 robs-hifi volumio[798]: at addChunk (internal/streams/readable.js:309:12) Feb 22 14:11:13 robs-hifi volumio[798]: at readableAddChunk (internal/streams/readable.js:284:9) Feb 22 14:11:13 robs-hifi volumio[798]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 250" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1635" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=trace msg="scheduling prefetch in 190s" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=trace msg="emitting websocket event: seek" Feb 22 14:11:13 robs-hifi go-librespot[968]: time="2025-02-22T14:11:13Z" level=debug msg="sending successful reply for dealer request" Feb 22 14:11:14 robs-hifi go-librespot[968]: time="2025-02-22T14:11:14Z" level=debug msg="fetched first chunk of 13, total size is 6472021 bytes" uri="spotify:track:6GOOcBV0wLoHrH5D9AWA32" Feb 22 14:11:14 robs-hifi go-librespot[968]: time="2025-02-22T14:11:14Z" level=trace msg="closed output device because of stop command" Feb 22 14:11:15 robs-hifi go-librespot[968]: time="2025-02-22T14:11:15Z" level=debug msg="put connect state inactive" Feb 22 14:11:15 robs-hifi systemd[1]: apt-daily.service: Succeeded. Feb 22 14:11:15 robs-hifi systemd[1]: Started Daily apt download activities. Feb 22 14:11:15 robs-hifi go-librespot[968]: time="2025-02-22T14:11:15Z" level=trace msg="emitting websocket event: inactive" Feb 22 14:11:15 robs-hifi go-librespot[968]: time="2025-02-22T14:11:15Z" level=trace msg="seek to 0ms (diff: 0ms, samples: 0, bytes: 0)" uri="spotify:track:6GOOcBV0wLoHrH5D9AWA32" Feb 22 14:11:15 robs-hifi go-librespot[968]: panic: send on closed channel Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 125 gp=0x12e3568 m=6 mp=0x1049708 [running]: Feb 22 14:11:15 robs-hifi go-librespot[968]: panic({0x5eaa68, 0x721780}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/panic.go:779 +0x12c fp=0x1167dcc sp=0x1167d78 pc=0x58364 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.chansend(0x11e8f00, 0x1167fd0, 0x1, 0x572550) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:206 +0x620 fp=0x1167e04 sp=0x1167dcc pc=0x1f1fc Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.chansend1(0x11e8f00, 0x1167fd0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:145 +0x28 fp=0x1167e1c sp=0x1167e04 pc=0x1ebd8 Feb 22 14:11:15 robs-hifi go-librespot[968]: go-librespot/player.(*Player).SetSecondaryStream(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/player/player.go:312 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*AppPlayer).prefetchNext(0x13e60f0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/controls.go:38 +0x440 fp=0x1167fe4 sp=0x1167e1c pc=0x572550 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*AppPlayer).schedulePrefetchNext.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/controls.go:56 +0x28 fp=0x1167fec sp=0x1167fe4 pc=0x572bc0 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1167fec sp=0x1167fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by main.(*AppPlayer).schedulePrefetchNext in goroutine 55 Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/controls.go:56 +0x1c8 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 1 gp=0x1002128 m=nil [select]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1166d0c sp=0x1166cf8 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.selectgo(0x1166e0c, 0x111ddd8, 0x0, 0x0, 0x2, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x1166dac sp=0x1166d0c pc=0x705e4 Feb 22 14:11:15 robs-hifi go-librespot[968]: go-librespot/zeroconf.(*Zeroconf).Serve(0x13e7810, 0x1166e88) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/zeroconf/zeroconf.go:268 +0x228 fp=0x1166e50 sp=0x1166dac pc=0x528ad8 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*App).withAppPlayer(0x10003f0, 0x1148400) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:297 +0x4b0 fp=0x1166ec0 sp=0x1166e50 pc=0x578904 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*App).withCredentials(0x10003f0, {0x5f2fc8, 0x100e520}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:171 +0x3d4 fp=0x1166f1c sp=0x1166ec0 pc=0x577fdc Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*App).SpotifyToken(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:131 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.main() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:466 +0x530 fp=0x1166fa8 sp=0x1166f1c pc=0x579f24 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.main() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:271 +0x2fc fp=0x1166fec sp=0x1166fa8 pc=0x5c29c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1166fec sp=0x1166fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 2 gp=0x1002a28 m=nil [force gc (idle)]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0xaa84c0, 0x11, 0xa, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1042fd4 sp=0x1042fc0 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.forcegchelper() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:326 +0xe4 fp=0x1042fec sp=0x1042fd4 pc=0x5c668 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1042fec sp=0x1042fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by runtime.init.5 in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:314 +0x1c Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 3 gp=0x1002b48 m=nil [runnable]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goschedIfBusy() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:365 +0x34 fp=0x10437c4 sp=0x10437b8 pc=0x5c714 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.bgsweep(0x106a000) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcsweep.go:302 +0x188 fp=0x10437e4 sp=0x10437c4 pc=0x450d8 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gcenable.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:203 +0x28 fp=0x10437ec sp=0x10437e4 pc=0x3518c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x10437ec sp=0x10437ec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by runtime.gcenable in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:203 +0x74 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 4 gp=0x1002c68 m=nil [GC scavenge wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0xaa9020, 0xd, 0xa, 0x2) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1043fb4 sp=0x1043fa0 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.(*scavengerState).park(0xaa9020) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1043fc8 sp=0x1043fb4 pc=0x4238c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.bgscavenge(0x106a000) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1043fe4 sp=0x1043fc8 pc=0x42ac4 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gcenable.gowrap2() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:204 +0x28 fp=0x1043fec sp=0x1043fe4 pc=0x35138 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1043fec sp=0x1043fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by runtime.gcenable in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:204 +0xbc Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 5 gp=0x1003208 m=nil [finalizer wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f5ec, 0xad3bac, 0x10, 0xa, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x104478c sp=0x1044778 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.runfinq() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mfinal.go:194 +0x110 fp=0x10447ec sp=0x104478c pc=0x33f78 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x10447ec sp=0x10447ec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by runtime.createfing in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mfinal.go:164 +0x5c Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 6 gp=0x10039e8 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607ff08, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x10425dc sp=0x10425c8 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fef8, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x10425f4 sp=0x10425dc pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fef8, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1042608 sp=0x10425f4 pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x1026fb8, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x104261c sp=0x1042608 pc=0x108108 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*FD).Accept(0x1026fa0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1042664 sp=0x104261c pc=0x10c974 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*netFD).accept(0x1026fa0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_unix.go:172 +0x20 fp=0x10426cc sp=0x1042664 pc=0x2a24f4 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*TCPListener).accept(0x10903a8) Feb 22 14:11:15 robs-hifi systemd[1]: Starting Daily apt upgrade and clean activities... Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock_posix.go:159 +0x20 fp=0x10426e4 sp=0x10426cc pc=0x2ba5f4 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*TCPListener).Accept(0x10903a8) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock.go:327 +0x30 fp=0x1042700 sp=0x10426e4 pc=0x2b9660 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*onceCloseListener).Accept(0x1148300) Feb 22 14:11:15 robs-hifi go-librespot[968]: :1 +0x34 fp=0x1042718 sp=0x1042700 pc=0x45e904 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*Server).Serve(0x10875e8, {0x724fbc, 0x10903a8}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3255 +0x314 fp=0x10427b0 sp=0x1042718 pc=0x43cfc0 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.Serve(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2794 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.(*ApiServer).serve(0x106fa00) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:470 +0x5ec fp=0x10427e4 sp=0x10427b0 pc=0x5706a4 Feb 22 14:11:15 robs-hifi go-librespot[968]: main.NewApiServer.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:240 +0x28 fp=0x10427ec sp=0x10427e4 pc=0x56fd78 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x10427ec sp=0x10427ec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by main.NewApiServer in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:240 +0x224 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 33 gp=0x1003b08 m=nil [select]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x10406a8 sp=0x1040694 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.selectgo(0x10407d4, 0x104076c, 0x0, 0x0, 0x2, 0x1) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x1040748 sp=0x10406a8 pc=0x705e4 Feb 22 14:11:15 robs-hifi go-librespot[968]: go-librespot/ap.(*Accesspoint).pongAckTicker(0x131a788) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:308 +0x8c fp=0x10407e4 sp=0x1040748 pc=0x48d36c Feb 22 14:11:15 robs-hifi go-librespot[968]: go-librespot/ap.NewAccesspoint.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:67 +0x28 fp=0x10407ec sp=0x10407e4 pc=0x48b70c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x10407ec sp=0x10407ec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by go-librespot/ap.NewAccesspoint in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:67 +0x188 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 16 gp=0x1003c28 m=nil [GC worker (idle)]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f5fc, 0x13c2ae0, 0x1a, 0xa, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1044f90 sp=0x1044f7c pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gcBgMarkWorker() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:1310 +0xec fp=0x1044fec sp=0x1044f90 pc=0x37db4 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1044fec sp=0x1044fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by runtime.gcBgMarkStartWorkers in goroutine 1 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/mgc.go:1234 +0x20 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 14 gp=0x1003d48 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fe68, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1058ad4 sp=0x1058ac0 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fe58, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x1058aec sp=0x1058ad4 pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fe58, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1058b00 sp=0x1058aec pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x1027288, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1058b14 sp=0x1058b00 pc=0x108108 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x1027270, {0x1131000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1058b5c sp=0x1058b14 pc=0x1092f4 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*netFD).Read(0x1027270, {0x1131000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x1058b88 sp=0x1058b5c pc=0x2a0600 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*conn).Read(0x102e960, {0x1131000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x1058bb4 sp=0x1058b88 pc=0x2b07e0 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x102e960, {0x1131000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: :1 +0x44 fp=0x1058bd4 sp=0x1058bb4 pc=0x2c3a34 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*atLeastReader).Read(0x13ed400, {0x1131000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:806 +0x78 fp=0x1058c00 sp=0x1058bd4 pc=0x386008 Feb 22 14:11:15 robs-hifi go-librespot[968]: bytes.(*Buffer).ReadFrom(0x10ce60c, {0x7237d8, 0x13ed400}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bytes/buffer.go:211 +0xa4 fp=0x1058c3c sp=0x1058c00 pc=0x136d6c Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readFromUntil(0x10ce488, {0x722344, 0x102e960}, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:828 +0xd4 fp=0x1058c64 sp=0x1058c3c pc=0x386264 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x10ce488, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:626 +0x134 fp=0x1058dc8 sp=0x1058c64 pc=0x383964 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x10ce488, {0x140f000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x1058df8 sp=0x1058dc8 pc=0x3897d4 Feb 22 14:11:15 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x13f3560, {0x1094ca4, 0x9, 0x9}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:241 +0x214 fp=0x1058e1c sp=0x1058df8 pc=0x15ab44 Feb 22 14:11:15 robs-hifi go-librespot[968]: io.ReadAtLeast({0x722538, 0x13f3560}, {0x1094ca4, 0x9, 0x9}, 0x9) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:335 +0x90 fp=0x1058e48 sp=0x1058e1c pc=0x1020b0 Feb 22 14:11:15 robs-hifi go-librespot[968]: io.ReadFull(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:354 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.http2readFrameHeader({0x1094ca4, 0x9, 0x9}, {0x722538, 0x13f3560}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1058e70 sp=0x1058e48 pc=0x3f30ec Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2Framer).ReadFrame(0x1094c80) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1058eec sp=0x1058e70 pc=0x3f3884 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2clientConnReadLoop).run(0x1058fdc) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1058fa4 sp=0x1058eec pc=0x4180a0 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2ClientConn).readLoop(0x10b5208) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1058fe4 sp=0x1058fa4 pc=0x417594 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1058fec sp=0x1058fe4 pc=0x4105e0 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1058fec sp=0x1058fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by net/http.(*http2Transport).newClientConn in goroutine 13 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0xcb0 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 20 gp=0x124aa28 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fd28, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1054e84 sp=0x1054e70 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fd18, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x1054e9c sp=0x1054e84 pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fd18, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1054eb0 sp=0x1054e9c pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x13e6068, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1054ec4 sp=0x1054eb0 pc=0x108108 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*FD).RawRead(0x13e6050, 0x1472a80) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1054ef0 sp=0x1054ec4 pc=0x10d578 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*rawConn).Read(0x13f6080, 0x1472a80) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/rawconn.go:44 +0x38 fp=0x1054f10 sp=0x1054ef0 pc=0x2b4a1c Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x13ec060, 0x1472a50, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/internal/socket/rawconn_msg.go:28 +0x154 fp=0x1054f40 sp=0x1054f10 pc=0x4c965c Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/internal/socket/socket.go:247 Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x13f2038, {0x1446000, 0x10000, 0x10000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/ipv4/payload_cmsg.go:32 +0x44c fp=0x1054f9c sp=0x1054f40 pc=0x4cd644 Feb 22 14:11:15 robs-hifi go-librespot[968]: github.com/grandcat/zeroconf.(*Server).recv4(0x13c6240, 0x13f2030) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1054fe0 sp=0x1054f9c pc=0x523ed4 Feb 22 14:11:15 robs-hifi go-librespot[968]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1054fec sp=0x1054fe0 pc=0x523b8c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1054fec sp=0x1054fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 18 Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 21 gp=0x124ab48 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fc88, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1040e5c sp=0x1040e48 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fc78, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x1040e74 sp=0x1040e5c pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fc78, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1040e88 sp=0x1040e74 pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x13e60b8, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1040e9c sp=0x1040e88 pc=0x108108 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*FD).RawRead(0x13e60a0, 0x13f23c0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1040ec8 sp=0x1040e9c pc=0x10d578 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*rawConn).Read(0x13f60a0, 0x13f23c0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/rawconn.go:44 +0x38 fp=0x1040ee8 sp=0x1040ec8 pc=0x2b4a1c Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x13ec070, 0x13f2390, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/internal/socket/rawconn_msg.go:28 +0x154 fp=0x1040f18 sp=0x1040ee8 pc=0x4c965c Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/internal/socket/socket.go:247 Feb 22 14:11:15 robs-hifi go-librespot[968]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x13f2068, {0x1436000, 0x10000, 0x10000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/golang.org/x/net@v0.11.0/ipv6/payload_cmsg.go:32 +0x2ec fp=0x1040f9c sp=0x1040f18 pc=0x4d0fcc Feb 22 14:11:15 robs-hifi go-librespot[968]: github.com/grandcat/zeroconf.(*Server).recv6(0x13c6240, 0x13f2060) Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x1040fe0 sp=0x1040f9c pc=0x5240c8 Feb 22 14:11:15 robs-hifi go-librespot[968]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x1040fec sp=0x1040fe0 pc=0x523b30 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1040fec sp=0x1040fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 18 Feb 22 14:11:15 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 29 gp=0x124aea8 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fbe8, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1057ad4 sp=0x1057ac0 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fbd8, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x1057aec sp=0x1057ad4 pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fbd8, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1057b00 sp=0x1057aec pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x13e7dc8, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1057b14 sp=0x1057b00 pc=0x108108 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x13e7db0, {0x1130000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1057b5c sp=0x1057b14 pc=0x1092f4 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*netFD).Read(0x13e7db0, {0x1130000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x1057b88 sp=0x1057b5c pc=0x2a0600 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*conn).Read(0x13f67a8, {0x1130000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x1057bb4 sp=0x1057b88 pc=0x2b07e0 Feb 22 14:11:15 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x13f67a8, {0x1130000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: :1 +0x44 fp=0x1057bd4 sp=0x1057bb4 pc=0x2c3a34 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*atLeastReader).Read(0x13ecac0, {0x1130000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:806 +0x78 fp=0x1057c00 sp=0x1057bd4 pc=0x386008 Feb 22 14:11:15 robs-hifi go-librespot[968]: bytes.(*Buffer).ReadFrom(0x10cf14c, {0x7237d8, 0x13ecac0}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bytes/buffer.go:211 +0xa4 fp=0x1057c3c sp=0x1057c00 pc=0x136d6c Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readFromUntil(0x10cefc8, {0x722344, 0x13f67a8}, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:828 +0xd4 fp=0x1057c64 sp=0x1057c3c pc=0x386264 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x10cefc8, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:626 +0x134 fp=0x1057dc8 sp=0x1057c64 pc=0x383964 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:15 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x10cefc8, {0x1457000, 0x1000, 0x1000}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x1057df8 sp=0x1057dc8 pc=0x3897d4 Feb 22 14:11:15 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x13f3da0, {0x1095324, 0x9, 0x9}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:241 +0x214 fp=0x1057e1c sp=0x1057df8 pc=0x15ab44 Feb 22 14:11:15 robs-hifi go-librespot[968]: io.ReadAtLeast({0x722538, 0x13f3da0}, {0x1095324, 0x9, 0x9}, 0x9) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:335 +0x90 fp=0x1057e48 sp=0x1057e1c pc=0x1020b0 Feb 22 14:11:15 robs-hifi go-librespot[968]: io.ReadFull(...) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:354 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.http2readFrameHeader({0x1095324, 0x9, 0x9}, {0x722538, 0x13f3da0}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1057e70 sp=0x1057e48 pc=0x3f30ec Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2Framer).ReadFrame(0x1095300) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1057eec sp=0x1057e70 pc=0x3f3884 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2clientConnReadLoop).run(0x1057fdc) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1057fa4 sp=0x1057eec pc=0x4180a0 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2ClientConn).readLoop(0x10b5408) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1057fe4 sp=0x1057fa4 pc=0x417594 Feb 22 14:11:15 robs-hifi go-librespot[968]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1057fec sp=0x1057fe4 pc=0x4105e0 Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1057fec sp=0x1057fec pc=0x9346c Feb 22 14:11:15 robs-hifi go-librespot[968]: created by net/http.(*http2Transport).newClientConn in goroutine 28 Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0xcb0 Feb 22 14:11:15 robs-hifi go-librespot[968]: goroutine 41 gp=0x10126c8 m=nil [IO wait]: Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607faa8, 0x2, 0x2, 0x5) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1059ad4 sp=0x1059ac0 pc=0x5c82c Feb 22 14:11:15 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fa98, 0x72, 0x0) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x1059aec sp=0x1059ad4 pc=0x540f0 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fa98, 0x72) Feb 22 14:11:15 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x1059b00 sp=0x1059aec pc=0x8eba8 Feb 22 14:11:15 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x147f3c8, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1059b14 sp=0x1059b00 pc=0x108108 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x147f3b0, {0x145d000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1059b5c sp=0x1059b14 pc=0x1092f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*netFD).Read(0x147f3b0, {0x145d000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x1059b88 sp=0x1059b5c pc=0x2a0600 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*conn).Read(0x102ec98, {0x145d000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x1059bb4 sp=0x1059b88 pc=0x2b07e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x102ec98, {0x145d000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: :1 +0x44 fp=0x1059bd4 sp=0x1059bb4 pc=0x2c3a34 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*atLeastReader).Read(0x100f130, {0x145d000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:806 +0x78 fp=0x1059c00 sp=0x1059bd4 pc=0x386008 Feb 22 14:11:16 robs-hifi go-librespot[968]: bytes.(*Buffer).ReadFrom(0x10cfecc, {0x7237d8, 0x100f130}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bytes/buffer.go:211 +0xa4 fp=0x1059c3c sp=0x1059c00 pc=0x136d6c Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readFromUntil(0x10cfd48, {0x722344, 0x102ec98}, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:828 +0xd4 fp=0x1059c64 sp=0x1059c3c pc=0x386264 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x10cfd48, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:626 +0x134 fp=0x1059dc8 sp=0x1059c64 pc=0x383964 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x10cfd48, {0x1139000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x1059df8 sp=0x1059dc8 pc=0x3897d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x1014d80, {0x10958a4, 0x9, 0x9}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:241 +0x214 fp=0x1059e1c sp=0x1059df8 pc=0x15ab44 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadAtLeast({0x722538, 0x1014d80}, {0x10958a4, 0x9, 0x9}, 0x9) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:335 +0x90 fp=0x1059e48 sp=0x1059e1c pc=0x1020b0 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadFull(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:354 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.http2readFrameHeader({0x10958a4, 0x9, 0x9}, {0x722538, 0x1014d80}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1059e70 sp=0x1059e48 pc=0x3f30ec Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2Framer).ReadFrame(0x1095880) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1059eec sp=0x1059e70 pc=0x3f3884 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2clientConnReadLoop).run(0x1059fdc) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1059fa4 sp=0x1059eec pc=0x4180a0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2ClientConn).readLoop(0x10b5508) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1059fe4 sp=0x1059fa4 pc=0x417594 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1059fec sp=0x1059fe4 pc=0x4105e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1059fec sp=0x1059fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by net/http.(*http2Transport).newClientConn in goroutine 40 Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0xcb0 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 52 gp=0x1012908 m=nil [select]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x103f6a8 sp=0x103f694 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.selectgo(0x103f7a4, 0x103f76c, 0x0, 0x0, 0x5, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x103f748 sp=0x103f6a8 pc=0x705e4 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x10fe8c8) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x103f7e4 sp=0x103f748 pc=0x47407c Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.newConn.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x103f7ec sp=0x103f7e4 pc=0x473c70 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x103f7ec sp=0x103f7ec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by nhooyr.io/websocket.newConn in goroutine 1 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 55 gp=0x1012b48 m=nil [runnable]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goyield(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:4149 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.semrelease1(0xa673b0, 0x1, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:249 +0x264 fp=0x111f69c sp=0x111f660 pc=0x715a4 Feb 22 14:11:16 robs-hifi go-librespot[968]: sync.runtime_Semrelease(0xa673b0, 0x1, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:72 +0x2c fp=0x111f6ac sp=0x111f69c pc=0x90738 Feb 22 14:11:16 robs-hifi go-librespot[968]: sync.(*Mutex).unlockSlow(0xa673ac, 0xc) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/mutex.go:257 +0x6c fp=0x111f6c0 sp=0x111f6ac pc=0x9eec0 Feb 22 14:11:16 robs-hifi go-librespot[968]: sync.(*Mutex).Unlock(0xa673ac) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/mutex.go:223 +0x44 fp=0x111f6d0 sp=0x111f6c0 pc=0x9ee44 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*MutexWrap).Unlock(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:67 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Entry).write.deferwrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:288 +0x34 fp=0x111f6d8 sp=0x111f6d0 pc=0x160ec0 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Entry).write(0x1392f00) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:297 +0x1d0 fp=0x111f71c sp=0x111f6d8 pc=0x160e5c Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Entry).log(0x1392e40, 0x6, {0x102df50, 0x22}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:252 +0x49c fp=0x111f7cc sp=0x111f71c pc=0x160928 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Entry).Log(0x1392e40, 0x6, {0x111f804, 0x1, 0x1}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:304 +0x78 fp=0x111f7e4 sp=0x111f7cc pc=0x160f64 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Entry).Logf(0x1392e40, 0x6, {0x672784, 0x1c}, {0x111f87c, 0x1, 0x1}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/entry.go:349 +0xc0 fp=0x111f80c sp=0x111f7e4 pc=0x161300 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Logger).Logf(0xa67390, 0x6, {0x672784, 0x1c}, {0x111f87c, 0x1, 0x1}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:154 +0x80 fp=0x111f830 sp=0x111f80c pc=0x16330c Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.(*Logger).Tracef(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/logger.go:160 Feb 22 14:11:16 robs-hifi go-librespot[968]: github.com/sirupsen/logrus.Tracef(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/sirupsen/logrus@v1.9.3/exported.go:184 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*ApiServer).Emit(0x106fa00, 0x138eb80) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:482 +0xd8 fp=0x111f890 sp=0x111f830 pc=0x571f08 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*AppPlayer).handleDealerMessage(0x13e60f0, {{0x1394e40, 0x1d}, 0x11a9300, {0x1832000, 0x7891, 0xa000}}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:124 +0x548 fp=0x111f8fc sp=0x111f890 pc=0x57aa8c Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*AppPlayer).Run(0x13e60f0, 0x11e9080) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:438 +0x318 fp=0x111ffe0 sp=0x111f8fc pc=0x57dec4 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*App).withAppPlayer.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:235 +0x30 fp=0x111ffec sp=0x111ffe0 pc=0x5792a4 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x111ffec sp=0x111ffec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by main.(*App).withAppPlayer in goroutine 1 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:235 +0x348 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 56 gp=0x1012c68 m=nil [chan receive]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f5d0, 0x106a270, 0xe, 0x7, 0x2) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1045f48 sp=0x1045f34 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.chanrecv(0x106a240, 0x1045fd0, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:583 +0x4b0 fp=0x1045f84 sp=0x1045f48 pc=0x1fdc4 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.chanrecv2(0x106a240, 0x1045fd0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:447 +0x20 fp=0x1045f98 sp=0x1045f84 pc=0x1f908 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*App).withAppPlayer.func1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:245 +0x54 fp=0x1045fec sp=0x1045f98 pc=0x5791d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1045fec sp=0x1045fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by main.(*App).withAppPlayer in goroutine 1 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:242 +0x3d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 57 gp=0x1012d88 m=nil [runnable]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.asyncPreempt2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt.go:307 +0x38 fp=0x11a0804 sp=0x11a07f8 pc=0x5abbc Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.asyncPreempt() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt_arm.s:44 +0x98 fp=0x11a08c0 sp=0x11a0804 pc=0x93fb4 Feb 22 14:11:16 robs-hifi go-librespot[968]: math/bits.Add64(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/math/bits/bits.go:391 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.bitsAdd64(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/bits_go1.13.go:12 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.updateGeneric(0x11a0a54, {0x113d57d, 0x490, 0xa83}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/sum_generic.go:222 +0x140 fp=0x11a0998 sp=0x11a08c4 pc=0x37803c Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.(*macGeneric).Write(0x11a0a54, {0x113d57d, 0x490, 0xa83}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/sum_generic.go:74 +0x15c fp=0x11a09c4 sp=0x11a0998 pc=0x377af0 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.(*MAC).Write(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/poly1305.go:80 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.writeWithPadding(0x11a0a54, {0x113d57d, 0x490, 0xa83}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_generic.go:16 +0x44 fp=0x11a09f4 sp=0x11a09c4 pc=0x378bdc Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).openGeneric(0x1096ae0, {0x113d57d, 0x0, 0xa83}, {0x1090e40, 0xc, 0xc}, {0x113d57d, 0x4a0, 0xa83}, ...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_generic.go:64 +0x1ac fp=0x11a0b5c sp=0x11a09f4 pc=0x3792f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).open(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_noasm.go:14 Feb 22 14:11:16 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).Open(0x1096ae0, {0x113d57d, 0x0, 0xa83}, {0x1090e40, 0xc, 0xc}, {0x113d57d, 0x4a0, 0xa83}, ...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305.go:82 +0xc4 fp=0x11a0ba8 sp=0x11a0b5c pc=0x378aec Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*xorNonceAEAD).Open(0x1090e40, {0x113d57d, 0x0, 0xa83}, {0x1160338, 0x8, 0x8}, {0x113d57d, 0x4a0, 0xa83}, ...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/cipher_suites.go:519 +0xc0 fp=0x11a0bf4 sp=0x11a0ba8 pc=0x37df94 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*halfConn).decrypt(0x1160314, {0x113d578, 0x4a5, 0xa88}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:380 +0x4bc fp=0x11a0ca0 sp=0x11a0bf4 pc=0x382668 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x1160248, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:686 +0xbfc fp=0x11a0e04 sp=0x11a0ca0 pc=0x38442c Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x1160248, {0x1186000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x11a0e34 sp=0x11a0e04 pc=0x3897d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*readWriteCloserBody).Read(0x100f9a0, {0x1186000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2429 +0xec fp=0x11a0e54 sp=0x11a0e34 pc=0x4538b0 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).fill(0x11748d0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:110 +0x10c fp=0x11a0e78 sp=0x11a0e54 pc=0x15a4b8 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).ReadByte(0x11748d0) Feb 22 14:11:16 robs-hifi mpd[949]: Feb 22 14:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:269 +0x28 fp=0x11a0e84 sp=0x11a0e78 pc=0x15ad3c Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).waitCloseHandshake(0x10fe8c8) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/close_notjs.go:114 +0x298 fp=0x11a0f18 sp=0x11a0e84 pc=0x472424 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).closeHandshake(0x10fe8c8, 0x3e9, {0x0, 0x0}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/close_notjs.go:38 +0x9c fp=0x11a0f58 sp=0x11a0f18 pc=0x471b20 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).Close(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/close_notjs.go:31 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/dealer.(*Dealer).Close(0x1086648) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/dealer/dealer.go:95 +0x70 fp=0x11a0f74 sp=0x11a0f58 pc=0x4b8384 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/session.(*Session).Close(0x13f20c0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/session/session.go:128 +0x3c fp=0x11a0f8c sp=0x11a0f74 pc=0x4c8c34 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*AppPlayer).Close(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/player.go:420 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*App).withAppPlayer.func2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:267 +0xe0 fp=0x11a0fec sp=0x11a0f8c pc=0x578e6c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a0fec sp=0x11a0fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by main.(*App).withAppPlayer in goroutine 1 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/main.go:258 +0x45c Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 58 gp=0x1012ea8 m=nil [IO wait]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fdc8, 0x2, 0x2, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x118dde8 sp=0x118ddd4 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fdb8, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x118de00 sp=0x118dde8 pc=0x540f0 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fdb8, 0x72) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x118de14 sp=0x118de00 pc=0x8eba8 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x13e6018, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x118de28 sp=0x118de14 pc=0x108108 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*FD).Accept(0x13e6000) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:611 +0x294 fp=0x118de70 sp=0x118de28 pc=0x10c974 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*netFD).accept(0x13e6000) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_unix.go:172 +0x20 fp=0x118ded8 sp=0x118de70 pc=0x2a24f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPListener).accept(0x140c048) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock_posix.go:159 +0x20 fp=0x118def0 sp=0x118ded8 pc=0x2ba5f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPListener).Accept(0x140c048) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/tcpsock.go:327 +0x30 fp=0x118df0c sp=0x118def0 pc=0x2b9660 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*onceCloseListener).Accept(0x147d620) Feb 22 14:11:16 robs-hifi go-librespot[968]: :1 +0x34 fp=0x118df24 sp=0x118df0c pc=0x45e904 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*Server).Serve(0x1086828, {0x724fbc, 0x140c048}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3255 +0x314 fp=0x118dfbc sp=0x118df24 pc=0x43cfc0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.Serve(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2794 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/zeroconf.(*Zeroconf).Serve.func2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/zeroconf/zeroconf.go:265 +0x8c fp=0x118dfec sp=0x118dfbc pc=0x528bd4 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x118dfec sp=0x118dfec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/zeroconf/zeroconf.go:265 +0x160 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 61 gp=0x1013328 m=nil [IO wait]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607fb48, 0x2, 0x2, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x116ad70 sp=0x116ad5c pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607fb38, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x116ad88 sp=0x116ad70 pc=0x540f0 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607fb38, 0x72) Feb 22 14:11:16 robs-hifi systemd[1]: Started Music Player Daemon. Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x116ad9c sp=0x116ad88 pc=0x8eba8 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x1026e78, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x116adb0 sp=0x116ad9c pc=0x108108 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x1026e60, {0x13f91b0, 0x3, 0x3}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x116adf8 sp=0x116adb0 pc=0x1092f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*netFD).Read(0x1026e60, {0x13f91b0, 0x3, 0x3}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x116ae24 sp=0x116adf8 pc=0x2a0600 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*conn).Read(0x13f6e80, {0x13f91b0, 0x3, 0x3}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x116ae50 sp=0x116ae24 pc=0x2b07e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x13f6e80, {0x13f91b0, 0x3, 0x3}) Feb 22 14:11:16 robs-hifi go-librespot[968]: :1 +0x44 fp=0x116ae70 sp=0x116ae50 pc=0x2c3a34 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadAtLeast({0x722344, 0x13f6e80}, {0x13f91b0, 0x3, 0x3}, 0x3) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:335 +0x90 fp=0x116ae9c sp=0x116ae70 pc=0x1020b0 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadFull(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:354 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/ap.(*shannonConn).receivePacket(0x14724e0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/shannon.go:80 +0x130 fp=0x116aefc sp=0x116ae9c pc=0x48fd34 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/ap.(*Accesspoint).recvLoop(0x131a788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:240 +0x58 fp=0x116afe4 sp=0x116aefc pc=0x48cbfc Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:229 +0x28 fp=0x116afec sp=0x116afe4 pc=0x48cb78 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x116afec sp=0x116afec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 55 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/ap/ap.go:229 +0x60 Feb 22 14:11:16 robs-hifi sudo[938]: pam_unix(sudo:session): session closed for user root Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 62 gp=0x1013448 m=nil [chan send]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f5d0, 0x11e9230, 0xf, 0x6, 0x2) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x111dcdc sp=0x111dcc8 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.chansend(0x11e9200, 0x111dd74, 0x1, 0x4b9cfc) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:259 +0x378 fp=0x111dd14 sp=0x111dcdc pc=0x1ef54 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.chansend1(0x11e9200, 0x111dd74) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:145 +0x28 fp=0x111dd2c sp=0x111dd14 pc=0x1ebd8 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/dealer.(*Dealer).handleMessage(0x1086648, 0x134cdc0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/dealer/recv.go:181 +0x600 fp=0x111df24 sp=0x111dd2c pc=0x4b9cfc Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/dealer.(*Dealer).recvLoop(0x1086648) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/dealer/dealer.go:170 +0x2b8 fp=0x111dfe4 sp=0x111df24 pc=0x4b8acc Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/dealer/dealer.go:99 +0x28 fp=0x111dfec sp=0x111dfe4 pc=0x4ba0c4 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x111dfec sp=0x111dfec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 55 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/dealer/dealer.go:99 +0x60 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 70 gp=0x119b328 m=nil [IO wait]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607f968, 0x2, 0x2, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x116bad4 sp=0x116bac0 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607f958, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x116baec sp=0x116bad4 pc=0x540f0 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607f958, 0x72) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x116bb00 sp=0x116baec pc=0x8eba8 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x11d0b58, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x116bb14 sp=0x116bb00 pc=0x108108 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:16 robs-hifi sudo[927]: pam_unix(sudo:session): session closed for user root Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x11d0b40, {0x11da000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x116bb5c sp=0x116bb14 pc=0x1092f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*netFD).Read(0x11d0b40, {0x11da000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x116bb88 sp=0x116bb5c pc=0x2a0600 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*conn).Read(0x1230228, {0x11da000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x116bbb4 sp=0x116bb88 pc=0x2b07e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x1230228, {0x11da000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: :1 +0x44 fp=0x116bbd4 sp=0x116bbb4 pc=0x2c3a34 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*atLeastReader).Read(0x138ea80, {0x11da000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:806 +0x78 fp=0x116bc00 sp=0x116bbd4 pc=0x386008 Feb 22 14:11:16 robs-hifi go-librespot[968]: bytes.(*Buffer).ReadFrom(0x116180c, {0x7237d8, 0x138ea80}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bytes/buffer.go:211 +0xa4 fp=0x116bc3c sp=0x116bc00 pc=0x136d6c Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readFromUntil(0x1161688, {0x722344, 0x1230228}, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:828 +0xd4 fp=0x116bc64 sp=0x116bc3c pc=0x386264 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x1161688, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:626 +0x134 fp=0x116bdc8 sp=0x116bc64 pc=0x383964 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:16 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x1161688, {0x11de000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x116bdf8 sp=0x116bdc8 pc=0x3897d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x11d8f60, {0x1192624, 0x9, 0x9}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:241 +0x214 fp=0x116be1c sp=0x116bdf8 pc=0x15ab44 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadAtLeast({0x722538, 0x11d8f60}, {0x1192624, 0x9, 0x9}, 0x9) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:335 +0x90 fp=0x116be48 sp=0x116be1c pc=0x1020b0 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.ReadFull(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:354 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.http2readFrameHeader({0x1192624, 0x9, 0x9}, {0x722538, 0x11d8f60}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1638 +0x54 fp=0x116be70 sp=0x116be48 pc=0x3f30ec Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2Framer).ReadFrame(0x1192600) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:1902 +0x88 fp=0x116beec sp=0x116be70 pc=0x3f3884 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2clientConnReadLoop).run(0x116bfdc) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9334 +0x150 fp=0x116bfa4 sp=0x116beec pc=0x4180a0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2ClientConn).readLoop(0x10b5608) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:9229 +0x68 fp=0x116bfe4 sp=0x116bfa4 pc=0x417594 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0x28 fp=0x116bfec sp=0x116bfe4 pc=0x4105e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x116bfec sp=0x116bfec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by net/http.(*http2Transport).newClientConn in goroutine 69 Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/h2_bundle.go:7879 +0xcb0 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 122 gp=0x12e2368 m=nil [runnable]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.asyncPreempt2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt.go:307 +0x38 fp=0x118c634 sp=0x118c628 pc=0x5abbc Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.asyncPreempt() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt_arm.s:44 +0x98 fp=0x118c6f0 sp=0x118c634 pc=0x93fb4 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/vorbis.(*Decoder).readNextPage(0x10e2c08) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/vorbis/decoder.go:336 +0x270 fp=0x118c73c sp=0x118c6f4 pc=0x4a6370 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/vorbis.(*Decoder).Read(0x10e2c08, {0x1466800, 0x1c2, 0x1c2}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/vorbis/decoder.go:268 +0x1e0 fp=0x118c760 sp=0x118c73c pc=0x4a5e60 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/player.(*SwitchingAudioSource).Read(0x100fa00, {0x1466800, 0x1c2, 0x1c2}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/player/source.go:52 +0x134 fp=0x118c798 sp=0x118c760 pc=0x4a91d4 Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/output.(*output).readLoop(0x12ea700) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/output/driver_unix.go:249 +0x68 fp=0x118c7d0 sp=0x118c798 pc=0x49a9dc Feb 22 14:11:16 robs-hifi go-librespot[968]: go-librespot/output.newOutput.func2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/output/driver_unix.go:93 +0x20 fp=0x118c7ec sp=0x118c7d0 pc=0x498d1c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x118c7ec sp=0x118c7ec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by go-librespot/output.newOutput in goroutine 54 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/output/driver_unix.go:92 +0x3d8 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 112 gp=0x12e2488 m=nil [select]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x11a7eb0 sp=0x11a7e9c pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.selectgo(0x11a7fac, 0x11a7f78, 0x0, 0x0, 0x2, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x11a7f50 sp=0x11a7eb0 pc=0x705e4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*persistConn).writeLoop(0x13d02c8) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2444 +0xd0 fp=0x11a7fe4 sp=0x11a7f50 pc=0x4539cc Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*Transport).dialConn.gowrap3() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1800 +0x28 fp=0x11a7fec sp=0x11a7fe4 pc=0x4507d8 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a7fec sp=0x11a7fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by net/http.(*Transport).dialConn in goroutine 102 Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1800 +0x1444 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 117 gp=0x12e3688 m=nil [select]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1165ea8 sp=0x1165e94 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.selectgo(0x1165fa4, 0x1165f6c, 0x0, 0x0, 0x5, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x1165f48 sp=0x1165ea8 pc=0x705e4 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x12e8f08) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1165fe4 sp=0x1165f48 pc=0x47407c Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.newConn.gowrap1() Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1165fec sp=0x1165fe4 pc=0x473c70 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1165fec sp=0x1165fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by nhooyr.io/websocket.newConn in goroutine 115 Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 113 gp=0x12e39e8 m=nil [select]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x11a4de4 sp=0x11a4dd0 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.selectgo(0x11a4f78, 0x11a4ebc, 0x0, 0x0, 0x4, 0x1) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x11a4e84 sp=0x11a4de4 pc=0x705e4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*persistConn).readLoop(0x13d0218) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2261 +0xc68 fp=0x11a4fe4 sp=0x11a4e84 pc=0x4529e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*Transport).dialConn.gowrap2() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1799 +0x28 fp=0x11a4fec sp=0x11a4fe4 pc=0x45082c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a4fec sp=0x11a4fec pc=0x9346c Feb 22 14:11:16 robs-hifi go-librespot[968]: created by net/http.(*Transport).dialConn in goroutine 98 Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1799 +0x13f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: goroutine 115 gp=0x12e3b08 m=nil [IO wait]: Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.gopark(0x68f730, 0xb607f648, 0x2, 0x2, 0x5) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x11a58a4 sp=0x11a5890 pc=0x5c82c Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.netpollblock(0xb607f638, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:573 +0x100 fp=0x11a58bc sp=0x11a58a4 pc=0x540f0 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.runtime_pollWait(0xb607f638, 0x72) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/netpoll.go:345 +0x54 fp=0x11a58d0 sp=0x11a58bc pc=0x8eba8 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).wait(0x134c6a8, 0x72, 0x0) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11a58e4 sp=0x11a58d0 pc=0x108108 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*pollDesc).waitRead(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_poll_runtime.go:89 Feb 22 14:11:16 robs-hifi go-librespot[968]: internal/poll.(*FD).Read(0x134c690, {0x13f1000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/internal/poll/fd_unix.go:164 +0x238 fp=0x11a592c sp=0x11a58e4 pc=0x1092f4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*netFD).Read(0x134c690, {0x13f1000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/fd_posix.go:55 +0x38 fp=0x11a5958 sp=0x11a592c pc=0x2a0600 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*conn).Read(0x1364248, {0x13f1000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/net.go:179 +0x48 fp=0x11a5984 sp=0x11a5958 pc=0x2b07e0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net.(*TCPConn).Read(0x1364248, {0x13f1000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: :1 +0x44 fp=0x11a59a4 sp=0x11a5984 pc=0x2c3a34 Feb 22 14:11:16 robs-hifi go-librespot[968]: io.(*multiReader).Read(0x138e990, {0x13f1000, 0x1000, 0x1000}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/multi.go:26 +0xb4 fp=0x11a59d0 sp=0x11a59a4 pc=0x103318 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).fill(0x13f3c20) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:110 +0x10c fp=0x11a59f4 sp=0x11a59d0 pc=0x15a4b8 Feb 22 14:11:16 robs-hifi go-librespot[968]: bufio.(*Reader).ReadByte(0x13f3c20) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:269 +0x28 fp=0x11a5a00 sp=0x11a59f4 pc=0x15ad3c Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.readFrameHeader(0x13f3c20, {0x12e8f38, 0x8, 0x8}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x11a5a40 sp=0x11a5a00 pc=0x4771d0 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x12e8f08, {0x7253c8, 0xad3b20}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x11a5b00 sp=0x11a5a40 pc=0x479e34 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).readLoop(0x12e8f08, {0x7253c8, 0xad3b20}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x11a5bc4 sp=0x11a5b00 pc=0x47991c Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).reader(0x12e8f08, {0x7253c8, 0xad3b20}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x11a5c50 sp=0x11a5bc4 pc=0x47ab30 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).Reader(...) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Feb 22 14:11:16 robs-hifi go-librespot[968]: nhooyr.io/websocket.(*Conn).Read(0x12e8f08, {0x7253c8, 0xad3b20}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x11a5c78 sp=0x11a5c50 pc=0x479200 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*ApiServer).serve.func14({0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:450 +0x22c fp=0x11a5cd0 sp=0x11a5c78 pc=0x570ae0 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.HandlerFunc.ServeHTTP(0x102e7b0, {0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2166 +0x34 fp=0x11a5ce0 sp=0x11a5cd0 pc=0x4395a4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*ServeMux).ServeHTTP(0x1094a80, {0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2683 +0x208 fp=0x11a5d1c sp=0x11a5ce0 pc=0x43b404 Feb 22 14:11:16 robs-hifi go-librespot[968]: main.(*ApiServer).serve.(*ApiServer).allowOriginMiddleware.func15({0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/cmd/daemon/api_server.go:273 +0xa4 fp=0x11a5d40 sp=0x11a5d1c pc=0x57089c Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.HandlerFunc.ServeHTTP(0x100e6a0, {0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2166 +0x34 fp=0x11a5d50 sp=0x11a5d40 pc=0x4395a4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.serverHandler.ServeHTTP({0x10875e8}, {0x7250f0, 0x1304828}, 0x1304788) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3137 +0xe0 fp=0x11a5d6c sp=0x11a5d50 pc=0x43cb94 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*conn).serve(0x12ee420, {0x7253e8, 0x1090558}) Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:2039 +0x61c fp=0x11a5fdc sp=0x11a5d6c pc=0x437de4 Feb 22 14:11:16 robs-hifi go-librespot[968]: net/http.(*Server).Serve.gowrap3() Feb 22 14:11:16 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3285 +0x38 fp=0x11a5fec sp=0x11a5fdc pc=0x43d438 Feb 22 14:11:16 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a5fec sp=0x11a5fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by net/http.(*Server).Serve in goroutine 6 Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/server.go:3285 +0x468 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 114 gp=0x12e3c28 m=nil [select]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x11a6eb0 sp=0x11a6e9c pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.selectgo(0x11a6fac, 0x11a6f78, 0x0, 0x0, 0x2, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x11a6f50 sp=0x11a6eb0 pc=0x705e4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).writeLoop(0x13d0218) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2444 +0xd0 fp=0x11a6fe4 sp=0x11a6f50 pc=0x4539cc Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).dialConn.gowrap3() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1800 +0x28 fp=0x11a6fec sp=0x11a6fe4 pc=0x4507d8 Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a6fec sp=0x11a6fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by net/http.(*Transport).dialConn in goroutine 98 Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1800 +0x1444 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 111 gp=0x12e3d48 m=nil [select]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x11a2de4 sp=0x11a2dd0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.selectgo(0x11a2f78, 0x11a2ebc, 0x0, 0x0, 0x4, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x11a2e84 sp=0x11a2de4 pc=0x705e4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).readLoop(0x13d02c8) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2261 +0xc68 fp=0x11a2fe4 sp=0x11a2e84 pc=0x4529e0 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).dialConn.gowrap2() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1799 +0x28 fp=0x11a2fec sp=0x11a2fe4 pc=0x45082c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x11a2fec sp=0x11a2fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by net/http.(*Transport).dialConn in goroutine 102 Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1799 +0x13f4 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 304 gp=0x12bf328 m=nil [runnable]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt2() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt.go:307 +0x38 fp=0x125f8b4 sp=0x125f8a8 pc=0x5abbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt_arm.s:44 +0x98 fp=0x125f970 sp=0x125f8b4 pc=0x93fb4 Feb 22 14:11:17 robs-hifi go-librespot[968]: math/bits.Mul64(0x4beda6f732efe8, 0x2be9079b658d5) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/math/bits/bits.go:476 +0x18 fp=0x125f97c sp=0x125f974 pc=0xc4be4 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/internal/edwards25519/field.addMul64({0xa188aa69eb9d92f3, 0x74bcab2af3}, 0x4beda6f732efe8, 0x2be9079b658d5) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/internal/edwards25519/field/fe_generic.go:23 +0x34 fp=0x125f9a0 sp=0x125f97c pc=0x31a954 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/internal/edwards25519/field.feMulGeneric(0x125fafc, 0x125fbec, 0x125fb74) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/internal/edwards25519/field/fe_generic.go:95 +0x35c fp=0x125fa9c sp=0x125f9a0 pc=0x31ad20 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/internal/edwards25519/field.feMul(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/internal/edwards25519/field/fe_amd64_noasm.go:9 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/internal/edwards25519/field.(*Element).Multiply(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/internal/edwards25519/field/fe.go:303 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/ecdh.x25519ScalarMult({0x1395ec0, 0x20, 0x20}, {0x1395de0, 0x20, 0x20}, {0x125fc48, 0x20, 0x20}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/ecdh/x25519.go:113 +0x214 fp=0x125fc20 sp=0x125fa9c pc=0x31ce48 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/ecdh.(*x25519Curve).privateKeyToPublicKey(0xad3b20, 0x1472630) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/ecdh/x25519.go:63 +0x140 fp=0x125fc74 sp=0x125fc20 pc=0x31c91c Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).makeClientHello.(*PrivateKey).PublicKey.func1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/ecdh/ecdh.go:178 +0x3c fp=0x125fca8 sp=0x125fc74 pc=0x38c298 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Once).doSlow(0x147264c, 0x125fd84) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/once.go:74 +0xc8 fp=0x125fcd4 sp=0x125fca8 pc=0x9f05c Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Once).Do(0x147264c, 0x125fd84) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/once.go:65 +0x40 fp=0x125fce0 sp=0x125fcd4 pc=0x9ef84 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/ecdh.(*PrivateKey).PublicKey(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/ecdh/ecdh.go:162 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).makeClientHello(0x12d1d48) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/handshake_client.go:156 +0xb6c fp=0x125fd8c sp=0x125fce0 pc=0x38bdf8 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).clientHandshake(0x12d1d48, {0x725408, 0x1472600}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/handshake_client.go:182 +0x78 fp=0x125fea0 sp=0x125fd8c pc=0x38c490 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).clientHandshake-fm({0x725408, 0x1472600}) Feb 22 14:11:17 robs-hifi go-librespot[968]: :1 +0x38 fp=0x125feb8 sp=0x125fea0 pc=0x3c4428 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).handshakeContext(0x12d1d48, {0x7253c8, 0xad3b20}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1553 +0x338 fp=0x125ffb0 sp=0x125feb8 pc=0x38a2fc Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).HandshakeContext(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1493 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).addTLS.func2() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1573 +0x78 fp=0x125ffec sp=0x125ffb0 pc=0x44e998 Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x125ffec sp=0x125ffec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by net/http.(*persistConn).addTLS in goroutine 294 Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1569 +0x2e4 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 301 gp=0x12bf448 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149dd0, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x18636f4 sp=0x18636e0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149dc8, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x1863720 sp=0x18636f4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149dc0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x1863744 sp=0x1863720 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x18637c4 sp=0x1863744 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x18637e4 sp=0x18637c4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x18637ec sp=0x18637e4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x18637ec sp=0x18637ec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 302 gp=0x12bf568 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149e10, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1863ef4 sp=0x1863ee0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149e08, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x1863f20 sp=0x1863ef4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149e00) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x1863f44 sp=0x1863f20 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x1863fc4 sp=0x1863f44 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x1863fe4 sp=0x1863fc4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x1863fec sp=0x1863fe4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1863fec sp=0x1863fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 303 gp=0x12bf7a8 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149e50, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x18646f4 sp=0x18646e0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149e48, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x1864720 sp=0x18646f4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149e40) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x1864744 sp=0x1864720 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x18647c4 sp=0x1864744 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x18647e4 sp=0x18647c4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x18647ec sp=0x18647e4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x18647ec sp=0x18647ec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 237 gp=0x1870248 m=nil [runnable]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt2() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt.go:307 +0x38 fp=0x1164790 sp=0x1164784 pc=0x5abbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt_arm.s:44 +0x98 fp=0x116484c sp=0x1164790 pc=0x93fb4 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20.quarterRound(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20/chacha_generic.go:129 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20.(*Cipher).xorKeyStreamBlocksGeneric(0x1164a64, {0x12aa281, 0x4000, 0x5d7f}, {0x12aa281, 0x4000, 0x5d7f}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20/chacha_generic.go:310 +0x9c8 fp=0x116496c sp=0x1164850 pc=0x377008 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20.(*Cipher).xorKeyStreamBlocks(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20/chacha_noasm.go:12 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20.(*Cipher).XORKeyStream(0x1164a64, {0x12aa281, 0x4001, 0x5d7f}, {0x12aa281, 0x4001, 0x5d7f}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20/chacha_generic.go:229 +0x1b0 fp=0x11649b4 sp=0x116496c pc=0x3762d8 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).openGeneric(0x1394680, {0x12aa281, 0x0, 0x5d7f}, {0x13462a0, 0xc, 0xc}, {0x12aa281, 0x4011, 0x5d7f}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_generic.go:79 +0x358 fp=0x1164b1c sp=0x11649b4 pc=0x3794a0 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).open(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_noasm.go:14 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).Open(0x1394680, {0x12aa281, 0x0, 0x5d7f}, {0x13462a0, 0xc, 0xc}, {0x12aa281, 0x4011, 0x5d7f}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305.go:82 +0xc4 fp=0x1164b68 sp=0x1164b1c pc=0x378aec Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*xorNonceAEAD).Open(0x13462a0, {0x12aa281, 0x0, 0x5d7f}, {0x12d0c38, 0x8, 0x8}, {0x12aa281, 0x4011, 0x5d7f}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/cipher_suites.go:519 +0xc0 fp=0x1164bb4 sp=0x1164b68 pc=0x37df94 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*halfConn).decrypt(0x12d0c14, {0x12aa27c, 0x4016, 0x5d84}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:380 +0x4bc fp=0x1164c60 sp=0x1164bb4 pc=0x382668 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x12d0b48, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:686 +0xbfc fp=0x1164dc4 sp=0x1164c60 pc=0x38442c Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x12d0b48, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x1164df4 sp=0x1164dc4 pc=0x3897d4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).Read(0x13d02c8, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1977 +0x16c fp=0x1164e28 sp=0x1164df4 pc=0x45137c Feb 22 14:11:17 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x13f2a50, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:227 +0x12c fp=0x1164e4c sp=0x1164e28 pc=0x15aa5c Feb 22 14:11:17 robs-hifi go-librespot[968]: io.(*LimitedReader).Read(0x138e900, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:479 +0xc4 fp=0x1164e6c sp=0x1164e4c pc=0x102878 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*body).readLocked(0x1472390, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transfer.go:840 +0x4c fp=0x1164e98 sp=0x1164e6c pc=0x446738 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*body).Read(0x1472390, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transfer.go:832 +0xe8 fp=0x1164ecc sp=0x1164e98 pc=0x446644 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*bodyEOFSignal).Read(0x14723c0, {0x139c000, 0x1500, 0x1500}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2833 +0xc0 fp=0x1164f08 sp=0x1164ecc pc=0x455560 Feb 22 14:11:17 robs-hifi go-librespot[968]: io.ReadAll({0x7224ac, 0x14723c0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:712 +0x84 fp=0x1164f44 sp=0x1164f08 pc=0x1030e8 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:169 +0x140 fp=0x1164fc4 sp=0x1164f44 pc=0x49257c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x1164fe4 sp=0x1164fc4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x1164fec sp=0x1164fe4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1164fec sp=0x1164fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 236 gp=0x1870368 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149e10, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x186a6f4 sp=0x186a6e0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149e08, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x186a720 sp=0x186a6f4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149e00) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x186a744 sp=0x186a720 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x186a7c4 sp=0x186a744 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x186a7e4 sp=0x186a7c4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x186a7ec sp=0x186a7e4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x186a7ec sp=0x186a7ec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 235 gp=0x1870488 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149dd0, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x186aef4 sp=0x186aee0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149dc8, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x186af20 sp=0x186aef4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149dc0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x186af44 sp=0x186af20 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x186afc4 sp=0x186af44 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x186afe4 sp=0x186afc4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x186afec sp=0x186afe4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x186afec sp=0x186afec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 234 gp=0x18705a8 m=nil [sync.Cond.Wait]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f740, 0x1149e50, 0x14, 0x4, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x186b6f4 sp=0x186b6e0 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goparkunlock(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:408 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.runtime_notifyListWait(0x1149e48, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/sema.go:569 +0x1e4 fp=0x186b720 sp=0x186b6f4 pc=0x90a94 Feb 22 14:11:17 robs-hifi go-librespot[968]: sync.(*Cond).Wait(0x1149e40) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/sync/cond.go:70 +0xbc fp=0x186b744 sp=0x186b720 pc=0x9cc44 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:139 +0x5b0 fp=0x186b7c4 sp=0x186b744 pc=0x4929ec Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x3) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x186b7e4 sp=0x186b7c4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x186b7ec sp=0x186b7e4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x186b7ec sp=0x186b7ec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 233 gp=0x18706c8 m=nil [select]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f774, 0x0, 0x9, 0x3, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x105288c sp=0x1052878 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.selectgo(0x10529c4, 0x105296c, 0x0, 0x0, 0x4, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/select.go:327 +0xaf0 fp=0x105292c sp=0x105288c pc=0x705e4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).getConn(0xa67ab0, 0x11f78e0, {{}, 0x0, {0x1114f20, 0x5}, {0x13957e0, 0x1c}, 0x0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1406 +0x4a0 fp=0x1052a5c sp=0x105292c pc=0x44d428 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).roundTrip(0xa67ab0, 0x1305688) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:595 +0x778 fp=0x1052b78 sp=0x1052a5c pc=0x449400 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).RoundTrip(0xa67ab0, 0x1305688) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/roundtrip.go:17 +0x24 fp=0x1052b90 sp=0x1052b78 pc=0x42d81c Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.send(0x1305688, {0x72268c, 0xa67ab0}, {0x0, 0x0, 0x0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/client.go:259 +0x540 fp=0x1052cbc sp=0x1052b90 pc=0x3e8544 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Client).send(0x1149640, 0x1305688, {0x0, 0x0, 0x0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/client.go:180 +0x98 fp=0x1052d00 sp=0x1052cbc pc=0x3e7e38 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Client).do(0x1149640, 0x1305688) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/client.go:724 +0x8bc fp=0x1052e10 sp=0x1052d00 pc=0x3ea238 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Client).Do(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/client.go:590 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).downloadChunk.func1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:111 +0x290 fp=0x1052e6c sp=0x1052e10 pc=0x492320 Feb 22 14:11:17 robs-hifi go-librespot[968]: github.com/cenkalti/backoff/v4.doRetryNotify[...](0x1052f38, {0x724c28, 0x11d4138}, 0x0, {0x0, 0x0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:88 +0xf0 fp=0x1052eec sp=0x1052e6c pc=0x4960ec Feb 22 14:11:17 robs-hifi go-librespot[968]: github.com/cenkalti/backoff/v4.RetryNotifyWithData[...](...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:54 Feb 22 14:11:17 robs-hifi go-librespot[968]: github.com/cenkalti/backoff/v4.RetryWithData[...](0x186bf38, {0x724c28, 0x11d4138}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/go/pkg/mod/github.com/cenkalti/backoff/v4@v4.2.1/retry.go:43 +0x54 fp=0x1052f18 sp=0x1052eec pc=0x495fd4 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).downloadChunk(0x135a870, 0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:110 +0x84 fp=0x1052f44 sp=0x1052f18 pc=0x492050 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:153 +0xc8 fp=0x1052fc4 sp=0x1052f44 pc=0x492504 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x1052fe4 sp=0x1052fc4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x1052fec sp=0x1052fe4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1052fec sp=0x1052fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 232 gp=0x18707e8 m=nil [runnable]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt2() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt.go:307 +0x38 fp=0x11687a0 sp=0x1168794 pc=0x5abbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.asyncPreempt() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/preempt_arm.s:44 +0x98 fp=0x116885c sp=0x11687a0 pc=0x93fb4 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.bitsMul64(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/bits_go1.13.go:20 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.mul64(0x4, 0xa125f0c0930d724) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/sum_generic.go:117 +0x38 fp=0x1168884 sp=0x1168860 pc=0x377e04 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.updateGeneric(0x1168a14, {0x12a198e, 0x4000, 0x4672}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/sum_generic.go:202 +0x738 fp=0x1168958 sp=0x1168884 pc=0x378634 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.(*macGeneric).Write(0x1168a14, {0x12a198e, 0x4001, 0x4672}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/sum_generic.go:74 +0x15c fp=0x1168984 sp=0x1168958 pc=0x377af0 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/internal/poly1305.(*MAC).Write(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/internal/poly1305/poly1305.go:80 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.writeWithPadding(0x1168a14, {0x12a198e, 0x4001, 0x4672}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_generic.go:16 +0x44 fp=0x11689b4 sp=0x1168984 pc=0x378bdc Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).openGeneric(0x1394d60, {0x12a198e, 0x0, 0x4672}, {0x1346318, 0xc, 0xc}, {0x12a198e, 0x4011, 0x4672}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_generic.go:64 +0x1ac fp=0x1168b1c sp=0x11689b4 pc=0x3792f4 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).open(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305_noasm.go:14 Feb 22 14:11:17 robs-hifi go-librespot[968]: vendor/golang.org/x/crypto/chacha20poly1305.(*chacha20poly1305).Open(0x1394d60, {0x12a198e, 0x0, 0x4672}, {0x1346318, 0xc, 0xc}, {0x12a198e, 0x4011, 0x4672}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/vendor/golang.org/x/crypto/chacha20poly1305/chacha20poly1305.go:82 +0xc4 fp=0x1168b68 sp=0x1168b1c pc=0x378aec Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*xorNonceAEAD).Open(0x1346318, {0x12a198e, 0x0, 0x4672}, {0x12d00f8, 0x8, 0x8}, {0x12a198e, 0x4011, 0x4672}, ...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/cipher_suites.go:519 +0xc0 fp=0x1168bb4 sp=0x1168b68 pc=0x37df94 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*halfConn).decrypt(0x12d00d4, {0x12a1989, 0x4016, 0x4677}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:380 +0x4bc fp=0x1168c60 sp=0x1168bb4 pc=0x382668 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecordOrCCS(0x12d0008, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:686 +0xbfc fp=0x1168dc4 sp=0x1168c60 pc=0x38442c Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).readRecord(...) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:588 Feb 22 14:11:17 robs-hifi go-librespot[968]: crypto/tls.(*Conn).Read(0x12d0008, {0x13eb000, 0x1000, 0x1000}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/crypto/tls/conn.go:1370 +0x15c fp=0x1168df4 sp=0x1168dc4 pc=0x3897d4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).Read(0x13d0218, {0x13eb000, 0x1000, 0x1000}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1977 +0x16c fp=0x1168e28 sp=0x1168df4 pc=0x45137c Feb 22 14:11:17 robs-hifi go-librespot[968]: bufio.(*Reader).Read(0x13f3200, {0x135795d, 0x6a3, 0x6a3}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/bufio/bufio.go:241 +0x214 fp=0x1168e4c sp=0x1168e28 pc=0x15ab44 Feb 22 14:11:17 robs-hifi go-librespot[968]: io.(*LimitedReader).Read(0x138e870, {0x135795d, 0x6a3, 0x6a3}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:479 +0xc4 fp=0x1168e6c sp=0x1168e4c pc=0x102878 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*body).readLocked(0x1472300, {0x135795d, 0x6a3, 0x6a3}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transfer.go:840 +0x4c fp=0x1168e98 sp=0x1168e6c pc=0x446738 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*body).Read(0x1472300, {0x135795d, 0x6a3, 0x6a3}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transfer.go:832 +0xe8 fp=0x1168ecc sp=0x1168e98 pc=0x446644 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*bodyEOFSignal).Read(0x1472330, {0x135795d, 0x6a3, 0x6a3}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:2833 +0xc0 fp=0x1168f08 sp=0x1168ecc pc=0x455560 Feb 22 14:11:17 robs-hifi go-librespot[968]: io.ReadAll({0x7224ac, 0x1472330}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/io/io.go:712 +0x84 fp=0x1168f44 sp=0x1168f08 pc=0x1030e8 Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).fetchChunk(0x135a870, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:169 +0x140 fp=0x1168fc4 sp=0x1168f44 pc=0x49257c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.func1(0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x24 fp=0x1168fe4 sp=0x1168fc4 pc=0x492c0c Feb 22 14:11:17 robs-hifi go-librespot[968]: go-librespot/audio.(*HttpChunkedReader).prefetchChunks.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x30 fp=0x1168fec sp=0x1168fe4 pc=0x492bbc Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1168fec sp=0x1168fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by go-librespot/audio.(*HttpChunkedReader).prefetchChunks in goroutine 125 Feb 22 14:11:17 robs-hifi go-librespot[968]: /home/runner/work/go-librespot/go-librespot/audio/chunked_reader.go:198 +0x34 Feb 22 14:11:17 robs-hifi go-librespot[968]: goroutine 294 gp=0x1870908 m=nil [chan receive]: Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.gopark(0x68f5d0, 0x1392cf0, 0xe, 0x7, 0x2) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/proc.go:402 +0x104 fp=0x1053b64 sp=0x1053b50 pc=0x5c82c Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.chanrecv(0x1392cc0, 0x1053ca4, 0x1) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:583 +0x4b0 fp=0x1053ba0 sp=0x1053b64 pc=0x1fdc4 Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.chanrecv1(0x1392cc0, 0x1053ca4) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/chan.go:442 +0x20 fp=0x1053bb4 sp=0x1053ba0 pc=0x1f8e4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*persistConn).addTLS(0x13d0008, {0x7253c8, 0xad3b20}, {0x13957e0, 0x18}, 0x0) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1579 +0x308 fp=0x1053cb0 sp=0x1053bb4 pc=0x44e6f4 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).dialConn(0xa67ab0, {0x7253c8, 0xad3b20}, {{}, 0x0, {0x1114f20, 0x5}, {0x13957e0, 0x1c}, 0x0}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1658 +0x8b0 fp=0x1053f48 sp=0x1053cb0 pc=0x44f330 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).dialConnFor(0xa67ab0, 0x12ee600) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1485 +0x84 fp=0x1053fe0 sp=0x1053f48 pc=0x44de40 Feb 22 14:11:17 robs-hifi go-librespot[968]: net/http.(*Transport).queueForDial.gowrap1() Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1449 +0x30 fp=0x1053fec sp=0x1053fe0 pc=0x44dd90 Feb 22 14:11:17 robs-hifi go-librespot[968]: runtime.goexit({}) Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/runtime/asm_arm.s:859 +0x4 fp=0x1053fec sp=0x1053fec pc=0x9346c Feb 22 14:11:17 robs-hifi go-librespot[968]: created by net/http.(*Transport).queueForDial in goroutine 233 Feb 22 14:11:17 robs-hifi go-librespot[968]: /opt/hostedtoolcache/go/1.22.2/x64/src/net/http/transport.go:1449 +0x98 Feb 22 14:11:17 robs-hifi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Feb 22 14:11:17 robs-hifi go-librespot[968]: Aborted Feb 22 14:11:17 robs-hifi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 22 14:11:20 robs-hifi sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-22 14:10 Feb 22 14:11:20 robs-hifi sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 14:11:20 robs-hifi systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Feb 22 14:11:20 robs-hifi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 22 14:11:20 robs-hifi systemd[1]: Stopped go-librespot Daemon. Feb 22 14:11:20 robs-hifi systemd[1]: Started go-librespot Daemon. Feb 22 14:11:20 robs-hifi go-librespot[1120]: Librespot-go daemon starting... Feb 22 14:11:20 robs-hifi systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 22 14:11:20 robs-hifi systemd[1]: Started Daily apt upgrade and clean activities. Feb 22 14:11:21 robs-hifi go-librespot[1120]: time="2025-02-22T14:11:21Z" level=info msg="generated new device id: b19816e343892e6e307ff180de395a9aa58df90c" Feb 22 14:11:21 robs-hifi go-librespot[1120]: time="2025-02-22T14:11:21Z" level=debug msg="stored credentials found for robster1111" PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"