Feb 24 16:06:11 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 522. Feb 24 16:06:11 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:11 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:11 volumio upmpdcli[21981]: Could not open config: /tmp/upmpdcli.conf Feb 24 16:06:11 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 16:06:11 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 16:06:26 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 523. Feb 24 16:06:26 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:26 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:26 volumio upmpdcli[22026]: Could not open config: /tmp/upmpdcli.conf Feb 24 16:06:26 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 16:06:26 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 16:06:29 volumio go-librespot[20788]: time="2026-02-24T16:06:29+01:00" level=trace msg="received accesspoint ping" Feb 24 16:06:29 volumio go-librespot[20788]: time="2026-02-24T16:06:29+01:00" level=trace msg="received accesspoint pong ack" Feb 24 16:06:29 volumio go-librespot[20788]: time="2026-02-24T16:06:29+01:00" level=trace msg="sent dealer ping" Feb 24 16:06:29 volumio go-librespot[20788]: time="2026-02-24T16:06:29+01:00" level=trace msg="received dealer pong" Feb 24 16:06:41 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 524. Feb 24 16:06:41 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:41 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:41 volumio upmpdcli[22058]: Could not open config: /tmp/upmpdcli.conf Feb 24 16:06:41 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 16:06:41 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="handling transfer player command from e76f04b34307e72a874eb25d4a2bf266559e13db" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="resolved context of track" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=trace msg="fetched new page 0 with 176 items (list: 176)" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=trace msg="emitting websocket event: will_play" Feb 24 16:06:55 volumio volumio[1165]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","play_origin":"playlist"}} Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 310" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="selected format OGG_VORBIS_320 (cbdb63c870fb4c86da98f2c3d5ecad3ff1b993a6)" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=debug msg="requested aes key for file cbdb63c870fb4c86da98f2c3d5ecad3ff1b993a6, gid: 5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:55 volumio go-librespot[20788]: time="2026-02-24T16:06:55+01:00" level=trace msg="found 2 cdn urls" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="fetched first chunk of 18, total size is 8953484 bytes" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="created new output device" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 100000 us, period size = 4410 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 5 frames, PCM format = FLOAT_LE" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=info msg="loaded track \"Spotlight\" (paused: false, position: 0ms, duration: 200515ms, prefetched: false)" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="fetched chunk 1/17, size: 524288" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="fetched chunk 2/17, size: 524288" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="fetched chunk 3/17, size: 524288" uri="spotify:track:5uqTDr0Z3gmgLFXcelq3NU" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=trace msg="scheduling prefetch in 170s" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=trace msg="emitting websocket event: metadata" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=trace msg="emitting websocket event: active" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="sending successful reply for dealer request" Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","name":"Spotlight","artist_names":["Mutemath"],"album_name":"Twilight Original Motion Picture Soundtrack (International Special Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e028d0b937a8653b9ed3f9fb926","position":0,"duration":200515,"release_date":"year:2008 month:11 day:3","track_number":5,"disc_number":1}} Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: received: {"type":"active","data":null} Feb 24 16:06:56 volumio volumio[1165]: info: Aligning Spotify Volume to Volumio Volume Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::volumioGetState Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 24 16:06:56 volumio volumio[1165]: info: Setting Spotify Volume from Volumio: 29 Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 24 16:06:56 volumio go-librespot[20788]: time="2026-02-24T16:06:56+01:00" level=trace msg="emitting websocket event: playing" Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","resume":false,"play_origin":"playlist"}} Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: PUSH STATE SPOTIFY Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: {"status":"play","service":"spop","title":"Spotlight","artist":"Mutemath","album":"Twilight Original Motion Picture Soundtrack (International Special Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e028d0b937a8653b9ed3f9fb926","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","trackType":"spotify","seek":0,"duration":200,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::servicePushState Feb 24 16:06:56 volumio volumio[1165]: info: CoreStateMachine::pushState Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: PUSH STATE SPOTIFY Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: {"status":"play","service":"spop","title":"Spotlight","artist":"Mutemath","album":"Twilight Original Motion Picture Soundtrack (International Special Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e028d0b937a8653b9ed3f9fb926","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","trackType":"spotify","seek":0,"duration":200,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::servicePushState Feb 24 16:06:56 volumio volumio[1165]: info: CoreStateMachine::pushState Feb 24 16:06:56 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState Feb 24 16:06:56 volumio volumio[1165]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Feb 24 16:06:56 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 525. Feb 24 16:06:56 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:56 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:06:56 volumio upmpdcli[22103]: Could not open config: /tmp/upmpdcli.conf Feb 24 16:06:56 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 16:06:56 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 16:06:57 volumio volumio[1165]: SPOTIFY: SETTING SPOTIFY VOLUME 29 Feb 24 16:06:57 volumio volumio[1165]: info: Sending Spotify command with payload to local API: /player/volume Feb 24 16:06:57 volumio go-librespot[20788]: time="2026-02-24T16:06:57+01:00" level=debug msg="update volume requested to 19005/65535" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="emitting websocket event: volume" Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: received: {"type":"volume","data":{"value":29,"max":100}} Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: RECEIVED SPOTIFY VOLUME 29 Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=info msg="playback was transferred to Urządzenie S23 użytkownika La" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="closed output device because of stop command" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 428" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="put connect state inactive" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="emitting websocket event: inactive" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="emitting websocket event: stopped" Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: received: {"type":"inactive","data":null} Feb 24 16:06:58 volumio volumio[1165]: error: Failed to decode event: inactive Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":""}} Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: PUSH STATE SPOTIFY Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: {"status":"stop","service":"spop","title":"Spotlight","artist":"Mutemath","album":"Twilight Original Motion Picture Soundtrack (International Special Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e028d0b937a8653b9ed3f9fb926","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","trackType":"spotify","seek":2000,"duration":200,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 24 16:06:58 volumio volumio[1165]: info: CoreCommandRouter::servicePushState Feb 24 16:06:58 volumio volumio[1165]: info: CoreStateMachine::pushState Feb 24 16:06:58 volumio volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 24 16:06:58 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState Feb 24 16:06:58 volumio volumio[1165]: info: CorePlayQueue::getTrack 19 Feb 24 16:06:58 volumio volumio[1165]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Spotlight","artist":"Mutemath","album":"Twilight Original Motion Picture Soundtrack (International Special Edition)","albumart":"https://i.scdn.co/image/ab67616d00001e028d0b937a8653b9ed3f9fb926","uri":"spotify:track:5uqTDr0Z3gmgLFXcelq3NU","trackType":"spotify","seek":2000,"duration":200,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Feb 24 16:06:58 volumio volumio[1165]: verbose: CURRENT POSITION 19 Feb 24 16:06:58 volumio volumio[1165]: info: CoreStateMachine::syncState stateService stop Feb 24 16:06:58 volumio volumio[1165]: info: CoreStateMachine::syncState currentStatus play Feb 24 16:06:58 volumio volumio[1165]: info: CoreCommandRouter::volumioPushState Feb 24 16:06:58 volumio volumio[1165]: info: CoreStateMachine::stPlaybackTimer Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Feb 24 16:06:58 volumio volumio[1165]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="dealer connection closed" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="dealer recv loop stopped" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="obtained new client token: AABjTFMcMCIeUzLqqMSGdE+7ZOa3Ou1gMMWw9hscB1sOGhthzuE2CD9Y81CFlfJtomfBs+kulW/OQLmY9WjSA0AH9WmY6zFc5/4fMceTqpcBvziratq2tJam3VhGLNpjwFiQUpv6Gs+rHkLI+KkOYIHcvSbuK2f5csYIc7Ho1TrtA3j18f7nhqC7Itbn5laGf4ejRJioIKRZtIdDdw0cqEjkfnPe1HWft8vvJsaOu0FJ9KM7GweQJMo/" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="completed keyexchange" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="completed challenge" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=info msg="authenticated AP" username="31************************5u" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=info msg="authenticated Login5" username="31************************5u" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="restored session after logout" username="31************************5u" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="dealer connection opened" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="starting accesspoint recv loop" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="starting dealer recv loop" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="received accesspoint ping" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="received connection id: YmIzOTViOTktNzIz...RUFFNkYyMUEyQQ==" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=trace msg="received accesspoint pong ack" Feb 24 16:06:58 volumio go-librespot[20788]: time="2026-02-24T16:06:58+01:00" level=debug msg="put connect state because NEW_DEVICE" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=debug msg="handling transfer player command from e76f04b34307e72a874eb25d4a2bf266559e13db" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=debug msg="resolved context of track" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=trace msg="fetched new page 0 with 176 items (list: 176)" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=debug msg="loading track (paused: false, position: 2903ms)" uri="spotify:track:6z5Yh7kOKeLjqIsNdokIpU" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=trace msg="emitting websocket event: will_play" Feb 24 16:07:05 volumio volumio[1165]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc","uri":"spotify:track:6z5Yh7kOKeLjqIsNdokIpU","play_origin":"playlist"}} Feb 24 16:07:05 volumio go-librespot[20788]: time="2026-02-24T16:07:05+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 310" Feb 24 16:07:05 volumio go-librespot[20788]: panic: runtime error: invalid memory address or nil pointer dereference Feb 24 16:07:05 volumio go-librespot[20788]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x9132ff] Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 491 gp=0xc00034efc0 m=6 mp=0xc0002da808 [running]: Feb 24 16:07:05 volumio go-librespot[20788]: panic({0xba9580?, 0x13f6450?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/panic.go:802 +0x168 fp=0xc000044ac8 sp=0xc000044a18 pc=0x4889e8 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.panicmem(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/panic.go:262 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.sigpanic() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/signal_unix.go:925 +0x359 fp=0xc000044b28 sp=0xc000044ac8 pc=0x48afb9 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/player.calculateNormalisationFactor(0x0, 0xa509a0?) Feb 24 16:07:05 volumio go-librespot[20788]: /src/player/player.go:521 +0x1f fp=0xc000044b50 sp=0xc000044b28 pc=0x9132ff Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/player.(*Player).NewStream(0xc000543480, {0xe0b308, 0xc00016d8f0}, 0xc000261b30, {{0xce4d20, 0x5}, {0xc0009bb110, 0x10, 0x10}}, 0x140, ...) Feb 24 16:07:05 volumio go-librespot[20788]: /src/player/player.go:615 +0x1207 fp=0xc000044cd8 sp=0xc000044b50 pc=0x9149e7 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*AppPlayer).loadCurrentTrack(0xc0004cdc80, {0xe0b308, 0xc00016d8f0}, 0x0, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/controls.go:333 +0x769 fp=0xc000044fc8 sp=0xc000044cd8 pc=0xa2a6c9 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*AppPlayer).handlePlayerCommand(_, {_, _}, {0x10308a94, {0xc000147620, 0x28}, {{0xc0007537d8, 0x8}, {0x0, 0x0}, ...}}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/player.go:243 +0x1a9a fp=0xc0000451d8 sp=0xc000044fc8 pc=0xa350fa Feb 24 16:07:05 volumio go-librespot[20788]: main.(*AppPlayer).handleDealerRequest(_, {_, _}, {0xc0006ba460, {0xc0001475c0, 0x24}, {0x10308a94, {0xc000147620, 0x28}, {{0xc0007537d8, ...}, ...}}}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/player.go:367 +0x1b0 fp=0xc000045458 sp=0xc0000451d8 pc=0xa35690 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*AppPlayer).Run(0xc0004cdc80, {0xe0b228, 0x1483020}, 0xc0000b37a0, 0xc0000b3810) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/player.go:685 +0x7b0 fp=0xc000045fa8 sp=0xc000045458 pc=0xa389f0 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).withAppPlayer.func2.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:328 +0x30 fp=0xc000045fe0 sp=0xc000045fa8 pc=0xa312d0 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000045fe8 sp=0xc000045fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by main.(*App).withAppPlayer.func2 in goroutine 58 Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:328 +0x2a8 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 1 gp=0xc000002380 m=nil [select, 8 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000045c60?, 0x2?, 0x60?, 0x91?, 0xc000045bfc?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00001da70 sp=0xc00001da50 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc00001dc60, 0xc000045bf8, 0x0?, 0x0, 0xbe7660?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00001dbb0 sp=0xc00001da70 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0xc00027c0a0, 0xc00001dd80) Feb 24 16:07:05 volumio go-librespot[20788]: /src/zeroconf/zeroconf.go:283 +0x29a fp=0xc00001dcf8 sp=0xc00001dbb0 pc=0x9a379a Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).withAppPlayer(0xc000145200, {0xe0b228, 0x1483020}, 0xc000286880) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:340 +0x590 fp=0xc00001de10 sp=0xc00001dcf8 pc=0xa30810 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).withCredentials(...) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:209 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).SpotifyToken(0xc000145200, {0xe0b228, 0x1483020}, {0xc000148e40?, 0xce6b7b?}, {0xc0001183c0?, 0x2697?}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:201 +0xc5 fp=0xc00001de68 sp=0xc00001de10 pc=0xa2fcc5 Feb 24 16:07:05 volumio go-librespot[20788]: main.main() Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:593 +0x745 fp=0xc00001df50 sp=0xc00001de68 pc=0xa32965 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.main() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:285 +0x29d fp=0xc00001dfe0 sp=0xc00001df50 pc=0x45509d Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00001dfe8 sp=0xc00001dfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 2 gp=0xc000002e00 m=nil [force gc (idle), 2 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x74c0f113cb7?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005afa8 sp=0xc00005af88 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goparkunlock(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.forcegchelper() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:373 +0xb3 fp=0xc00005afe0 sp=0xc00005afa8 pc=0x4553d3 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005afe8 sp=0xc00005afe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.init.7 in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:361 +0x1a Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 3 gp=0xc000003340 m=nil [GC sweep wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x1?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005b780 sp=0xc00005b760 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goparkunlock(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.bgsweep(0xc00007e000) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgcsweep.go:323 +0xdf fp=0xc00005b7c8 sp=0xc00005b780 pc=0x43f29f Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcenable.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:212 +0x25 fp=0xc00005b7e0 sp=0xc00005b7c8 pc=0x4332a5 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005b7e8 sp=0xc00005b7e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.gcenable in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:212 +0x66 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 4 gp=0xc000003500 m=nil [GC scavenge wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x12a3a9ab?, 0x1296cba0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005bf78 sp=0xc00005bf58 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goparkunlock(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.(*scavengerState).park(0x1461b00) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc00005bfa8 sp=0xc00005bf78 pc=0x43cd29 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.bgscavenge(0xc00007e000) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0xc00005bfc8 sp=0xc00005bfa8 pc=0x43d2d9 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcenable.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:213 +0x25 fp=0xc00005bfe0 sp=0xc00005bfc8 pc=0x433245 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005bfe8 sp=0xc00005bfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.gcenable in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:213 +0xa5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 18 gp=0xc000100000 m=nil [GOMAXPROCS updater (idle), 8 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000056788 sp=0xc000056768 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goparkunlock(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.updateMaxProcsGoroutine() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:6720 +0xe7 fp=0xc0000567e0 sp=0xc000056788 pc=0x4632c7 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000567e8 sp=0xc0000567e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:6708 +0x37 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 19 gp=0xc000100540 m=nil [finalizer wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x0?, 0xc00055c890?, 0x20?, 0xa0?, 0x1000000010?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005a620 sp=0xc00005a600 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.runFinalizers() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mfinal.go:210 +0x107 fp=0xc00005a7e0 sp=0xc00005a620 pc=0x4321a7 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005a7e8 sp=0xc00005a7e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.createfing in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mfinal.go:172 +0x3d Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 20 gp=0xc000101340 m=nil [cleanup wait, 6 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x7fc801755800?, 0xc000056f90?, 0xb5?, 0x7a?, 0x7fc801755800?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000056f68 sp=0xc000056f48 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goparkunlock(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.(*cleanupQueue).dequeue(0x1461f40) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mcleanup.go:439 +0xc5 fp=0xc000056fa0 sp=0xc000056f68 pc=0x42f3c5 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.runCleanups() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mcleanup.go:635 +0x45 fp=0xc000056fe0 sp=0xc000056fa0 pc=0x42fa85 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000056fe8 sp=0xc000056fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mcleanup.go:589 +0xa5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 23 gp=0xc0001016c0 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006fa58 sp=0xc00006fa38 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0xc00006faa8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006fa90 sp=0xc00006fa58 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066e00, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006fab0 sp=0xc00006fa90 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc000198900?, 0x900000036?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006fad8 sp=0xc00006fab0 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Accept(0xc000198900) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00006fb80 sp=0xc00006fad8 pc=0x50fc4c Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).accept(0xc000198900) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00006fc38 sp=0xc00006fb80 pc=0x57c449 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*TCPListener).accept(0xc00012d2c0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00006fc88 sp=0xc00006fc38 pc=0x591bbb Feb 24 16:07:05 volumio go-librespot[20788]: net.(*TCPListener).Accept(0xc00012d2c0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00006fcb8 sp=0xc00006fc88 pc=0x590d90 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*onceCloseListener).Accept(0xc0004d0120?) Feb 24 16:07:05 volumio go-librespot[20788]: :1 +0x24 fp=0xc00006fcd0 sp=0xc00006fcb8 pc=0x73aaa4 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Server).Serve(0xc0000aa000, {0xe0a190, 0xc00012d2c0}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00006fe00 sp=0xc00006fcd0 pc=0x712a0c Feb 24 16:07:05 volumio go-librespot[20788]: net/http.Serve(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2971 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*ConcreteApiServer).serve(0xc00025e3f0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/api_server.go:666 +0x90c fp=0xc00006ffc8 sp=0xc00006fe00 pc=0xa25c4c Feb 24 16:07:05 volumio go-librespot[20788]: main.NewApiServer.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/api_server.go:332 +0x25 fp=0xc00006ffe0 sp=0xc00006ffc8 pc=0xa24985 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006ffe8 sp=0xc00006ffe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by main.NewApiServer in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/api_server.go:332 +0x2ff Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 9 gp=0xc000101880 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000485d58?, 0x486a25?, 0x0?, 0xc7?, 0x87?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000485d28 sp=0xc000485d08 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000485d60 sp=0xc000485d28 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066800, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000485d80 sp=0xc000485d60 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0000a4580?, 0x7fc801787600?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000485da8 sp=0xc000485d80 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).RawRead(0xc0000a4580, 0xc00032d9a0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc000485e08 sp=0xc000485da8 pc=0x5108c5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*rawConn).Read(0xc000114050, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc000485e40 sp=0xc000485e08 pc=0x58ccf6 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003a6140, 0xc0003ab200, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc000485ea0 sp=0xc000485e40 pc=0x941a85 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0xc000170380, {0xc0002a0000, 0x10000, 0x10000}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x225 fp=0xc000485f48 sp=0xc000485ea0 pc=0x945265 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/grandcat/zeroconf.(*Server).recv4(0xc0004dc0c0, 0xc000170370) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xc7 fp=0xc000485fc0 sp=0xc000485f48 pc=0x99e627 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x25 fp=0xc000485fe0 sp=0xc000485fc0 pc=0x99e2c5 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000485fe8 sp=0xc000485fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 32 Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x78 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 474 gp=0xc000101a40 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x24fb?, 0xc000376748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0003766f8 sp=0xc0003766d8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000376730 sp=0xc0003766f8 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066200, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000376750 sp=0xc000376730 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0004cde80?, 0xc0007f0000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000376778 sp=0xc000376750 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc0004cde80, {0xc0007f0000, 0x1000, 0x1000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000376810 sp=0xc000376778 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc0004cde80, {0xc0007f0000?, 0xc0004cde80?, 0xc000515400?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc000376858 sp=0xc000376810 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc00005ead8, {0xc0007f0000?, 0x7fc802068630?, 0x7fc849cbd5c0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0003768a0 sp=0xc000376858 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*atLeastReader).Read(0xc00047ce58, {0xc0007f0000?, 0x0?, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0003768e8 sp=0xc0003768a0 pc=0x63f87b Feb 24 16:07:05 volumio go-librespot[20788]: bytes.(*Buffer).ReadFrom(0xc0004c7b28, {0xe03f40, 0xc00047ce58}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc000376940 sp=0xc0003768e8 pc=0x534958 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readFromUntil(0xc0004c7888, {0xe01ea0, 0xc00005ead8}, 0x450db4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc000376978 sp=0xc000376940 pc=0x63fa5e Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecordOrCCS(0xc0004c7888, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc000376bf0 sp=0xc000376978 pc=0x63cadb Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).Read(0xc0004c7888, {0xc0007fe000, 0x1000, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc000376c58 sp=0xc000376bf0 pc=0x643385 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).Read(0xc0004938c0, {0xc00017c200, 0x9, 0x486a45?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc000376c90 sp=0xc000376c58 pc=0x68e6f7 Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadAtLeast({0xe02280, 0xc0004938c0}, {0xc00017c200, 0x9, 0x9}, 0x9) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc000376cd8 sp=0xc000376c90 pc=0x4c8bae Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadFull(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.http2readFrameHeader({0xc00017c200, 0x9, 0xc000376d80?}, {0xe02280?, 0xc0004938c0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc000376d28 sp=0xc000376cd8 pc=0x6cbd45 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Framer).ReadFrame(0xc00017c1c0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc000376e10 sp=0xc000376d28 pc=0x6cc41d Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2clientConnReadLoop).run(0xc000376fa8) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc000376f60 sp=0xc000376e10 pc=0x6ef5ba Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2ClientConn).readLoop(0xc0007fc000) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc000376fc8 sp=0xc000376f60 pc=0x6ee939 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc000376fe0 sp=0xc000376fc8 pc=0x6e8665 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000376fe8 sp=0xc000376fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*http2Transport).newClientConn in goroutine 473 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 7 gp=0xc000349340 m=nil [GC worker (idle)]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x74c90db92b2?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006df38 sp=0xc00006df18 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcBgMarkWorker(0xc0000b3810) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00006dfc8 sp=0xc00006df38 pc=0x43598b Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcBgMarkStartWorkers.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00006dfe0 sp=0xc00006dfc8 pc=0x435865 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006dfe8 sp=0xc00006dfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 8 gp=0xc000349500 m=nil [GC worker (idle)]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x74c90db827e?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00067bf38 sp=0xc00067bf18 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcBgMarkWorker(0xc0000b3810) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc00067bfc8 sp=0xc00067bf38 pc=0x43598b Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gcBgMarkStartWorkers.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc00067bfe0 sp=0xc00067bfc8 pc=0x435865 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00067bfe8 sp=0xc00067bfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 10 gp=0xc000348000 m=nil [IO wait, 8 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x56d9613400010282?, 0x35a3dd4d558712b5?, 0x60?, 0x40?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000071ce0 sp=0xc000071cc0 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000071d18 sp=0xc000071ce0 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066600, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000071d38 sp=0xc000071d18 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0000a4600?, 0x7fc8020948c0?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000071d60 sp=0xc000071d38 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).RawRead(0xc0000a4600, 0xc0004da0a0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc000071dc0 sp=0xc000071d60 pc=0x5108c5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*rawConn).Read(0xc0001140c0, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc000071df8 sp=0xc000071dc0 pc=0x58ccf6 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc0003a6160, 0xc00008a240, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc000071e58 sp=0xc000071df8 pc=0x941a85 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Feb 24 16:07:05 volumio go-librespot[20788]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0xc0001703d0, {0xc000290000, 0x10000, 0x10000}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x265 fp=0xc000071f48 sp=0xc000071e58 pc=0x948725 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/grandcat/zeroconf.(*Server).recv6(0xc0004dc0c0, 0xc0001703c0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xc7 fp=0xc000071fc0 sp=0xc000071f48 pc=0x99e7e7 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x25 fp=0xc000071fe0 sp=0xc000071fc0 pc=0x99e265 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000071fe8 sp=0xc000071fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 32 Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xd9 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 507 gp=0xc0002e6700 m=nil [chan receive]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x7fc849cbd5c0?, 0xc00012aea0?, 0x8?, 0xa8?, 0xc00001bb78?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00001bb28 sp=0xc00001bb08 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv(0xc0006ba460, 0xc00001bbff, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc00001bba0 sp=0xc00001bb28 pc=0x422773 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv1(0xc000901000?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:509 +0x12 fp=0xc00001bbc8 sp=0xc00001bba0 pc=0x4222d2 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0xc0004622a0, 0xc0006fd440) Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/recv.go:237 +0x245 fp=0xc00001be98 sp=0xc00001bbc8 pc=0x9304e5 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0xc0004622a0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:213 +0x388 fp=0xc00001bfc8 sp=0xc00001be98 pc=0x92eca8 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:125 +0x25 fp=0xc00001bfe0 sp=0xc00001bfc8 pc=0x92e505 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00001bfe8 sp=0xc00001bfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 491 Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:125 +0x78 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 508 gp=0xc000348380 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000728798?, 0x2?, 0x40?, 0x4f?, 0xc000728744?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0007285c8 sp=0xc0007285a8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000728798, 0xc000728740, 0xa8cbb5275a3db3cc?, 0x0, 0x6a8ed90e4d4db63e?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000728708 sp=0xc0007285c8 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0xc0004622a0) Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:138 +0x8f fp=0xc0007287c8 sp=0xc000728708 pc=0x92e5cf Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:129 +0x25 fp=0xc0007287e0 sp=0xc0007287c8 pc=0x92e4a5 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0007287e8 sp=0xc0007287e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 491 Feb 24 16:07:05 volumio go-librespot[20788]: /src/dealer/dealer.go:129 +0xf6 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 57 gp=0xc000348540 m=nil [chan receive]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc00008a000?, 0xc00012acc0?, 0x0?, 0x0?, 0xc0000c6ee8?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0000c6e98 sp=0xc0000c6e78 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv(0xc000102310, 0xc0000c6f98, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc0000c6f10 sp=0xc0000c6e98 pc=0x422773 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv2(0xc0000c6fb0?, 0x99e627?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc0000c6f38 sp=0xc0000c6f10 pc=0x4222f2 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).withAppPlayer.func1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:284 +0x72 fp=0xc0000c6fe0 sp=0xc0000c6f38 pc=0xa31372 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000c6fe8 sp=0xc0000c6fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by main.(*App).withAppPlayer in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:281 +0x45f Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 58 gp=0xc000348700 m=nil [chan receive]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000019ee0?, 0x91ec3c?, 0x30?, 0xc9?, 0x5?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000019e98 sp=0xc000019e78 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv(0xc0001022a0, 0xc000019fb8, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000019f10 sp=0xc000019e98 pc=0x422773 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.chanrecv2(0xc000149760?, 0xcf687c?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000019f38 sp=0xc000019f10 pc=0x4222f2 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*App).withAppPlayer.func2() Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:300 +0x87 fp=0xc000019fe0 sp=0xc000019f38 pc=0xa30fa7 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000019fe8 sp=0xc000019fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by main.(*App).withAppPlayer in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/main.go:297 +0x51f Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 59 gp=0xc0003488c0 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006bbe0 sp=0xc00006bbc0 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0xc00006bc30?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006bc18 sp=0xc00006bbe0 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066a00, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006bc38 sp=0xc00006bc18 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0000a4200?, 0x900000036?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006bc60 sp=0xc00006bc38 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Accept(0xc0000a4200) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00006bd08 sp=0xc00006bc60 pc=0x50fc4c Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).accept(0xc0000a4200) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00006bdc0 sp=0xc00006bd08 pc=0x57c449 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*TCPListener).accept(0xc00012cdc0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00006be10 sp=0xc00006bdc0 pc=0x591bbb Feb 24 16:07:05 volumio go-librespot[20788]: net.(*TCPListener).Accept(0xc00012cdc0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00006be40 sp=0xc00006be10 pc=0x590d90 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*onceCloseListener).Accept(0xc0006fd200?) Feb 24 16:07:05 volumio go-librespot[20788]: :1 +0x24 fp=0xc00006be58 sp=0xc00006be40 pc=0x73aaa4 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Server).Serve(0xc0000aa800, {0xe0a190, 0xc00012cdc0}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00006bf88 sp=0xc00006be58 pc=0x712a0c Feb 24 16:07:05 volumio go-librespot[20788]: net/http.Serve(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2971 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Feb 24 16:07:05 volumio go-librespot[20788]: /src/zeroconf/zeroconf.go:280 +0x85 fp=0xc00006bfe0 sp=0xc00006bf88 pc=0x9a38a5 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006bfe8 sp=0xc00006bfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Feb 24 16:07:05 volumio go-librespot[20788]: /src/zeroconf/zeroconf.go:280 +0x156 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 74 gp=0xc0002e6fc0 m=nil [IO wait, 8 minutes]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc0004ab310?, 0x925374?, 0x45?, 0x66?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004ab2e0 sp=0xc0004ab2c0 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0004ab318 sp=0xc0004ab2e0 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc801745800, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0004ab338 sp=0xc0004ab318 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc00048be00?, 0xc0003df000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0004ab360 sp=0xc0004ab338 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc00048be00, {0xc0003df000, 0x1000, 0x1000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0004ab3f8 sp=0xc0004ab360 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc00048be00, {0xc0003df000?, 0x488f0e?, 0x1?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0004ab440 sp=0xc0004ab3f8 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc000114208, {0xc0003df000?, 0x2?, 0x45ec3f?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0004ab488 sp=0xc0004ab440 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: io.(*multiReader).Read(0xc0004228e8, {0xc0003df000, 0x1000, 0x1000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/multi.go:26 +0x93 fp=0xc0004ab4d0 sp=0xc0004ab488 pc=0x4c9a73 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).fill(0xc000492000) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc0004ab508 sp=0xc0004ab4d0 pc=0x68e1c3 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).ReadByte(0xc000492000) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:273 +0x27 fp=0xc0004ab528 sp=0xc0004ab508 pc=0x68e8e7 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.readFrameHeader(0xc000492000, {0xc000175da8, 0x8, 0x8}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x85 fp=0xc0004ab5b8 sp=0xc0004ab528 pc=0x84aa65 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).readFrameHeader(0xc000175d40, {0xe0b1f0, 0x1483020}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xd6 fp=0xc0004ab6f8 sp=0xc0004ab5b8 pc=0x84c6b6 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).readLoop(0xc000175d40, {0xe0b1f0, 0x1483020}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x65 fp=0xc0004ab858 sp=0xc0004ab6f8 pc=0x84c025 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).reader(0xc000175d40, {0xe0b1f0, 0x1483020}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0x10f fp=0xc0004ab948 sp=0xc0004ab858 pc=0x84d4af Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).Reader(...) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).Read(0xc00025e468?, {0xe0b1f0?, 0x1483020?}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x1e fp=0xc0004ab978 sp=0xc0004ab948 pc=0x84b67e Feb 24 16:07:05 volumio go-librespot[20788]: main.(*ConcreteApiServer).serve.func17({0xe0a310, 0xc0001e4d20}, 0xc000498ae0?) Feb 24 16:07:05 volumio go-librespot[20788]: /src/cmd/daemon/api_server.go:636 +0x3ac fp=0xc0004aba68 sp=0xc0004ab978 pc=0xa2640c Feb 24 16:07:05 volumio go-librespot[20788]: net/http.HandlerFunc.ServeHTTP(0xc000094000?, {0xe0a310?, 0xc0001e4d20?}, 0x2000000000000?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0004aba90 sp=0xc0004aba68 pc=0x70f109 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*ServeMux).ServeHTTP(0xc0000981a0?, {0xe0a310, 0xc0001e4d20}, 0xc0004e6640) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2861 +0x1c7 fp=0xc0004abae0 sp=0xc0004aba90 pc=0x710fe7 Feb 24 16:07:05 volumio go-librespot[20788]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xe0a310, 0xc0001e4d20}, 0xc0004e6640) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x164 fp=0xc0004abb38 sp=0xc0004abae0 pc=0xa25e84 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.HandlerFunc.ServeHTTP(0x485cb9?, {0xe0a310?, 0xc0001e4d20?}, 0xc000484b68?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0004abb60 sp=0xc0004abb38 pc=0x70f109 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.serverHandler.ServeHTTP({0xc000442740?}, {0xe0a310?, 0xc0001e4d20?}, 0x1?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:3340 +0x8e fp=0xc0004abb90 sp=0xc0004abb60 pc=0x72e58e Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*conn).serve(0xc00048f440, {0xe0b260, 0xc0000364e0}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:2109 +0x665 fp=0xc0004abfb8 sp=0xc0004abb90 pc=0x70d205 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Server).Serve.gowrap3() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:3493 +0x28 fp=0xc0004abfe0 sp=0xc0004abfb8 pc=0x712e08 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004abfe8 sp=0xc0004abfe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*Server).Serve in goroutine 23 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/server.go:3493 +0x485 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 130 gp=0xc0002e7340 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x216f84eca3406a7e?, 0x84b55343014d10e7?, 0x61?, 0xf3?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000373768 sp=0xc000373748 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0003737a0 sp=0xc000373768 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066000, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0003737c0 sp=0xc0003737a0 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0004cd900?, 0xc00052a000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0003737e8 sp=0xc0003737c0 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc0004cd900, {0xc00052a000, 0xa000, 0xa000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000373880 sp=0xc0003737e8 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc0004cd900, {0xc00052a000?, 0x1018702eb8afa880?, 0x7610c50a4e8b21b5?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0003738c8 sp=0xc000373880 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc0001141f0, {0xc00052a000?, 0x7fc8017844a0?, 0x7fc849cbd108?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc000373910 sp=0xc0003738c8 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*atLeastReader).Read(0xc0004472c0, {0xc00052a000?, 0xa133582fc641550a?, 0xe733c4f81c15479d?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc000373958 sp=0xc000373910 pc=0x63f87b Feb 24 16:07:05 volumio go-librespot[20788]: bytes.(*Buffer).ReadFrom(0xc0004c7428, {0xe03f40, 0xc0004472c0}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0003739b0 sp=0xc000373958 pc=0x534958 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readFromUntil(0xc0004c7188, {0xe01ea0, 0xc0001141f0}, 0x450db4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0003739e8 sp=0xc0003739b0 pc=0x63fa5e Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecordOrCCS(0xc0004c7188, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc000373c60 sp=0xc0003739e8 pc=0x63cadb Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).Read(0xc0004c7188, {0xc000396000, 0x1000, 0xc00028c9f0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc000373cc8 sp=0xc000373c60 pc=0x643385 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).Read(0xc0003beb40, {0xc000396000?, 0x720045?, 0xe01aa0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2125 +0x47 fp=0xc000373d28 sp=0xc000373cc8 pc=0x727527 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).fill(0xc00008bb00) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc000373d60 sp=0xc000373d28 pc=0x68e1c3 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).Peek(0xc00008bb00, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:152 +0x53 fp=0xc000373d80 sp=0xc000373d60 pc=0x68e2f3 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).readLoop(0xc0003beb40) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2278 +0x172 fp=0xc000373fc8 sp=0xc000373d80 pc=0x728032 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Transport).dialConn.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1947 +0x25 fp=0xc000373fe0 sp=0xc000373fc8 pc=0x726a65 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000373fe8 sp=0xc000373fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*Transport).dialConn in goroutine 120 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1947 +0x174f Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 76 gp=0xc0002e7500 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000487f40?, 0x5?, 0x89?, 0x6e?, 0xc000487ee6?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000487d68 sp=0xc000487d48 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000487f40, 0xc000487edc, 0x48631a?, 0x0, 0xc000496640?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000487ea8 sp=0xc000487d68 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc000175d40) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc000487fc8 sp=0xc000487ea8 pc=0x847556 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.newConn.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc000487fe0 sp=0xc000487fc8 pc=0x847165 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000487fe8 sp=0xc000487fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by nhooyr.io/websocket.newConn in goroutine 74 Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 131 gp=0xc0002e76c0 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000483f48?, 0x2?, 0xc0?, 0x3d?, 0xc000483ef4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000483d78 sp=0xc000483d58 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000483f48, 0xc000483ef0, 0xc00039cc40?, 0x0, 0x0?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000483eb8 sp=0xc000483d78 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).writeLoop(0xc0003beb40) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2600 +0xe7 fp=0xc000483fc8 sp=0xc000483eb8 pc=0x729a47 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Transport).dialConn.gowrap3() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1948 +0x25 fp=0xc000483fe0 sp=0xc000483fc8 pc=0x726a05 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000483fe8 sp=0xc000483fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*Transport).dialConn in goroutine 120 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1948 +0x17a5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 97 gp=0xc0002e7880 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x24fb?, 0xc00006a748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Feb 24 16:07:05 volumio volumio[1165]: info: Connection to go-librespot Websocket closed Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006a6f8 sp=0xc00006a6d8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006a730 sp=0xc00006a6f8 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc801745a00, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006a750 sp=0xc00006a730 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc0004cc700?, 0xc000340000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006a778 sp=0xc00006a750 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc0004cc700, {0xc000340000, 0x1000, 0x1000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc00006a810 sp=0xc00006a778 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc0004cc700, {0xc000340000?, 0xc0004cc700?, 0xc000515400?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc00006a858 sp=0xc00006a810 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc00005e000, {0xc000340000?, 0x7fc802068630?, 0x7fc849cbd5c0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc00006a8a0 sp=0xc00006a858 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*atLeastReader).Read(0xc00047de48, {0xc000340000?, 0x0?, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc00006a8e8 sp=0xc00006a8a0 pc=0x63f87b Feb 24 16:07:05 volumio go-librespot[20788]: bytes.(*Buffer).ReadFrom(0xc0004650a8, {0xe03f40, 0xc00047de48}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc00006a940 sp=0xc00006a8e8 pc=0x534958 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readFromUntil(0xc000464e08, {0xe01ea0, 0xc00005e000}, 0x450db4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc00006a978 sp=0xc00006a940 pc=0x63fa5e Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecordOrCCS(0xc000464e08, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc00006abf0 sp=0xc00006a978 pc=0x63cadb Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).Read(0xc000464e08, {0xc00035c000, 0x1000, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc00006ac58 sp=0xc00006abf0 pc=0x643385 Feb 24 16:07:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).Read(0xc0003aad80, {0xc00017c2e0, 0x9, 0x486a45?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc00006ac90 sp=0xc00006ac58 pc=0x68e6f7 Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadAtLeast({0xe02280, 0xc0003aad80}, {0xc00017c2e0, 0x9, 0x9}, 0x9) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc00006acd8 sp=0xc00006ac90 pc=0x4c8bae Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadFull(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.http2readFrameHeader({0xc00017c2e0, 0x9, 0xc00006ad80?}, {0xe02280?, 0xc0003aad80?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc00006ad28 sp=0xc00006acd8 pc=0x6cbd45 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Framer).ReadFrame(0xc00017c2a0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc00006ae10 sp=0xc00006ad28 pc=0x6cc41d Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2clientConnReadLoop).run(0xc00006afa8) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc00006af60 sp=0xc00006ae10 pc=0x6ef5ba Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2ClientConn).readLoop(0xc000349180) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc00006afc8 sp=0xc00006af60 pc=0x6ee939 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc00006afe0 sp=0xc00006afc8 pc=0x6e8665 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006afe8 sp=0xc00006afe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*http2Transport).newClientConn in goroutine 96 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 159 gp=0xc000349c00 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc0003a7240?, 0xc000482788?, 0xe5?, 0xac?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000482768 sp=0xc000482748 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0004827a0 sp=0xc000482768 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066400, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0004827c0 sp=0xc0004827a0 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc000552580?, 0xc0006c6000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0004827e8 sp=0xc0004827c0 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc000552580, {0xc0006c6000, 0xa000, 0xa000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000482880 sp=0xc0004827e8 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc000552580, {0xc0006c6000?, 0xc00020f800?, 0x5?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0004828c8 sp=0xc000482880 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc00005e008, {0xc0006c6000?, 0x7fc802068630?, 0x7fc849cbd5c0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc000482910 sp=0xc0004828c8 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*atLeastReader).Read(0xc00047c450, {0xc0006c6000?, 0x17fb?, 0xc0004829e8?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc000482958 sp=0xc000482910 pc=0x63f87b Feb 24 16:07:05 volumio go-librespot[20788]: bytes.(*Buffer).ReadFrom(0xc0004c77a8, {0xe03f40, 0xc00047c450}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0004829b0 sp=0xc000482958 pc=0x534958 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readFromUntil(0xc0004c7508, {0xe01ea0, 0xc00005e008}, 0x450db4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0004829e8 sp=0xc0004829b0 pc=0x63fa5e Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecordOrCCS(0xc0004c7508, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc000482c60 sp=0xc0004829e8 pc=0x63cadb Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).Read(0xc0004c7508, {0xc0003de000, 0x1000, 0xc00028c9f0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc000482cc8 sp=0xc000482c60 pc=0x643385 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).Read(0xc00053e120, {0xc0003de000?, 0x720045?, 0xe01aa0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2125 +0x47 fp=0xc000482d28 sp=0xc000482cc8 pc=0x727527 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).fill(0xc0003aacc0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc000482d60 sp=0xc000482d28 pc=0x68e1c3 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).Peek(0xc0003aacc0, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:152 +0x53 fp=0xc000482d80 sp=0xc000482d60 pc=0x68e2f3 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).readLoop(0xc00053e120) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2278 +0x172 fp=0xc000482fc8 sp=0xc000482d80 pc=0x728032 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Transport).dialConn.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1947 +0x25 fp=0xc000482fe0 sp=0xc000482fc8 pc=0x726a65 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000482fe8 sp=0xc000482fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*Transport).dialConn in goroutine 125 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1947 +0x174f Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 160 gp=0xc000349dc0 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000481f48?, 0x2?, 0xc0?, 0x1d?, 0xc000481ef4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000481d78 sp=0xc000481d58 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000481f48, 0xc000481ef0, 0xc00039c8c0?, 0x0, 0x0?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000481eb8 sp=0xc000481d78 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*persistConn).writeLoop(0xc00053e120) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:2600 +0xe7 fp=0xc000481fc8 sp=0xc000481eb8 pc=0x729a47 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*Transport).dialConn.gowrap3() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1948 +0x25 fp=0xc000481fe0 sp=0xc000481fc8 pc=0x726a05 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000481fe8 sp=0xc000481fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*Transport).dialConn in goroutine 125 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/transport.go:1948 +0x17a5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 498 gp=0xc00034ec40 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x5fb?, 0xc000374748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0003746f8 sp=0xc0003746d8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000374730 sp=0xc0003746f8 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc802066c00, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000374750 sp=0xc000374730 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc000542300?, 0xc000816000?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000374778 sp=0xc000374750 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc000542300, {0xc000816000, 0x1000, 0x1000}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000374810 sp=0xc000374778 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc000542300, {0xc000816000?, 0xc000542300?, 0xc00042ac00?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc000374858 sp=0xc000374810 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc00005eb60, {0xc000816000?, 0x7fc80206ae30?, 0x7fc849cbd108?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0003748a0 sp=0xc000374858 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*atLeastReader).Read(0xc0004227f8, {0xc000816000?, 0x0?, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0003748e8 sp=0xc0003748a0 pc=0x63f87b Feb 24 16:07:05 volumio go-librespot[20788]: bytes.(*Buffer).ReadFrom(0xc0004c7ea8, {0xe03f40, 0xc0004227f8}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc000374940 sp=0xc0003748e8 pc=0x534958 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readFromUntil(0xc0004c7c08, {0xe01ea0, 0xc00005eb60}, 0x450db4?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc000374978 sp=0xc000374940 pc=0x63fa5e Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecordOrCCS(0xc0004c7c08, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc000374bf0 sp=0xc000374978 pc=0x63cadb Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:05 volumio go-librespot[20788]: crypto/tls.(*Conn).Read(0xc0004c7c08, {0xc00081c000, 0x1000, 0x0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc000374c58 sp=0xc000374bf0 pc=0x643385 Feb 24 16:07:05 volumio go-librespot[20788]: bufio.(*Reader).Read(0xc00012a1e0, {0xc00017c4a0, 0x9, 0x486a45?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc000374c90 sp=0xc000374c58 pc=0x68e6f7 Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadAtLeast({0xe02280, 0xc00012a1e0}, {0xc00017c4a0, 0x9, 0x9}, 0x9) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc000374cd8 sp=0xc000374c90 pc=0x4c8bae Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadFull(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.http2readFrameHeader({0xc00017c4a0, 0x9, 0xc000374d80?}, {0xe02280?, 0xc00012a1e0?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc000374d28 sp=0xc000374cd8 pc=0x6cbd45 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Framer).ReadFrame(0xc00017c460) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc000374e10 sp=0xc000374d28 pc=0x6cc41d Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2clientConnReadLoop).run(0xc000374fa8) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc000374f60 sp=0xc000374e10 pc=0x6ef5ba Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2ClientConn).readLoop(0xc0007fc1c0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc000374fc8 sp=0xc000374f60 pc=0x6ee939 Feb 24 16:07:05 volumio go-librespot[20788]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc000374fe0 sp=0xc000374fc8 pc=0x6e8665 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000374fe8 sp=0xc000374fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by net/http.(*http2Transport).newClientConn in goroutine 481 Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 490 gp=0xc00034ee00 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000471f20?, 0x3?, 0x70?, 0x63?, 0xc000471eda?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000471d60 sp=0xc000471d40 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000471f20, 0xc000471ed4, 0xc000471ec0?, 0x0, 0xc000471ef8?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000471ea0 sp=0xc000471d60 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0xc000543480) Feb 24 16:07:05 volumio go-librespot[20788]: /src/player/player.go:215 +0x205 fp=0xc000471fc8 sp=0xc000471ea0 pc=0x911e65 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/player/player.go:197 +0x25 fp=0xc000471fe0 sp=0xc000471fc8 pc=0x911a25 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000471fe8 sp=0xc000471fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 58 Feb 24 16:07:05 volumio go-librespot[20788]: /src/player/player.go:197 +0x1e5 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 506 gp=0xc00034f180 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc000727798?, 0x2?, 0x40?, 0x4f?, 0xc00072776c?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0007275f8 sp=0xc0007275d8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc000727798, 0xc000727768, 0xbeff5b04bcf5fab7?, 0x0, 0xc58f7f3f63585f2d?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000727738 sp=0xc0007275f8 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0xc0001e4e10) Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:368 +0x7d fp=0xc0007277c8 sp=0xc000727738 pc=0x8a627d Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap2() Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:277 +0x25 fp=0xc0007277e0 sp=0xc0007277c8 pc=0x8a5905 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0007277e8 sp=0xc0007277e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 491 Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:277 +0xff Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 505 gp=0xc00034f340 m=nil [IO wait]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0x0?, 0x64?, 0x58?, 0xb?, 0xb?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000370ae8 sp=0xc000370ac8 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000370b20 sp=0xc000370ae8 pc=0x44d977 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.runtime_pollWait(0x7fc801745c00, 0x72) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000370b40 sp=0xc000370b20 pc=0x4880e5 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).wait(0xc000553500?, 0xc000753c5c?, 0x0) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000370b68 sp=0xc000370b40 pc=0x50a827 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:05 volumio go-librespot[20788]: internal/poll.(*FD).Read(0xc000553500, {0xc000753c5c, 0x3, 0x3}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000370c00 sp=0xc000370b68 pc=0x50bb19 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*netFD).Read(0xc000553500, {0xc000753c5c?, 0x91e23f?, 0xc00016de30?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc000370c48 sp=0xc000370c00 pc=0x57a5a5 Feb 24 16:07:05 volumio go-librespot[20788]: net.(*conn).Read(0xc000114a18, {0xc000753c5c?, 0xc000370cc8?, 0x48b089?}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc000370c90 sp=0xc000370c48 pc=0x588ac5 Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadAtLeast({0xe01ea0, 0xc000114a18}, {0xc000753c5c, 0x3, 0x3}, 0x3) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc000370cd8 sp=0xc000370c90 pc=0x4c8bae Feb 24 16:07:05 volumio go-librespot[20788]: io.ReadFull(...) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0xc0003aaa20, {0xe0b228, 0x1483020}) Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/shannon.go:124 +0x37e fp=0xc000370e18 sp=0xc000370cd8 pc=0x8a8d7e Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0xc0001e4e10) Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:289 +0x6c fp=0xc000370fc8 sp=0xc000370e18 pc=0x8a5a0c Feb 24 16:07:05 volumio go-librespot[20788]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:273 +0x25 fp=0xc000370fe0 sp=0xc000370fc8 pc=0x8a5965 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000370fe8 sp=0xc000370fe0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 491 Feb 24 16:07:05 volumio go-librespot[20788]: /src/ap/ap.go:273 +0x78 Feb 24 16:07:05 volumio go-librespot[20788]: goroutine 504 gp=0xc00034f500 m=nil [select]: Feb 24 16:07:05 volumio go-librespot[20788]: runtime.gopark(0xc0000c7740?, 0x5?, 0x32?, 0x80?, 0xc0000c76e6?) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0000c7568 sp=0xc0000c7548 pc=0x488f0e Feb 24 16:07:05 volumio go-librespot[20788]: runtime.selectgo(0xc0000c7740, 0xc0000c76dc, 0x3e9?, 0x0, 0x0?, 0x1) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0000c76a8 sp=0xc0000c7568 pc=0x467bd7 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc0003f8340) Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc0000c77c8 sp=0xc0000c76a8 pc=0x847556 Feb 24 16:07:05 volumio go-librespot[20788]: nhooyr.io/websocket.newConn.gowrap1() Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc0000c77e0 sp=0xc0000c77c8 pc=0x847165 Feb 24 16:07:05 volumio go-librespot[20788]: runtime.goexit({}) Feb 24 16:07:05 volumio go-librespot[20788]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000c77e8 sp=0xc0000c77e0 pc=0x490a41 Feb 24 16:07:05 volumio go-librespot[20788]: created by nhooyr.io/websocket.newConn in goroutine 491 Feb 24 16:07:05 volumio go-librespot[20788]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Feb 24 16:07:05 volumio go-librespot[20787]: Aborted Feb 24 16:07:08 volumio volumio[1165]: info: Initializing connection to go-librespot Websocket Feb 24 16:07:08 volumio volumio[1165]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 16:07:08 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Feb 24 16:07:08 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 24 16:07:08 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 24 16:07:08 volumio go-librespot[22131]: go-librespot daemon starting... Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=info msg="running go-librespot 0.6.2" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=debug msg="app state loaded" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 24 16:07:08 volumio go-librespot[22132]: time="2026-02-24T16:07:08+01:00" level=info msg="zeroconf server listening on port 40313" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="obtained new client token: AAC9Qu+BOfpYwbm4AWRfeFYOM8lolBbJXVs5wiCytSLFUNIGdA8Sm9wTJxFU6YsDAVgHzJcdZba+k1XJUBKG/cR2ZoBKlIo98KgalU/zLuO82dLXv0VNbaYKz/kt2vAR1t+EBwtCmWaBENUv3NIpnj58IIe0gP1fA9rT3lniM4f9GUUfpvL5Q0UHjoZaw5Qllx8bNg61UXsISh2EHKA5goyXFRvEhRDn7VsXi9p7MK/LeN2kdIrim88J" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="completed keyexchange" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="completed challenge" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=info msg="authenticated AP" username="31************************5u" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=info msg="authenticated Login5" username="31************************5u" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="initializing zeroconf session" username="31************************5u" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="dealer connection opened" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=trace msg="starting accesspoint recv loop" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=trace msg="starting dealer recv loop" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=trace msg="received accesspoint ping" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="received connection id: YzNhNjUyZWMtYjM2...NTI4MUUyRkE2Nw==" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=trace msg="received accesspoint pong ack" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="put connect state because NEW_DEVICE" Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 24 16:07:09 volumio go-librespot[22132]: time="2026-02-24T16:07:09+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 428" Feb 24 16:07:11 volumio volumio[1165]: info: Initializing connection to go-librespot Websocket Feb 24 16:07:11 volumio go-librespot[22132]: time="2026-02-24T16:07:11+01:00" level=debug msg="new websocket client" Feb 24 16:07:11 volumio volumio[1165]: info: Connection to go-librespot Websocket established Feb 24 16:07:12 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 526. Feb 24 16:07:12 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:07:12 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 24 16:07:12 volumio upmpdcli[22144]: Could not open config: /tmp/upmpdcli.conf Feb 24 16:07:12 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 24 16:07:12 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=debug msg="handling transfer player command from e76f04b34307e72a874eb25d4a2bf266559e13db" Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=debug msg="resolved context of track" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=trace msg="fetched new page 0 with 176 items (list: 176)" uri="spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc" Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=debug msg="loading track (paused: false, position: 10414ms)" uri="spotify:track:6z5Yh7kOKeLjqIsNdokIpU" Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=trace msg="emitting websocket event: will_play" Feb 24 16:07:13 volumio volumio[1165]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:playlist:6hGsTvMbfKCUPLxdM3jaXc","uri":"spotify:track:6z5Yh7kOKeLjqIsNdokIpU","play_origin":"playlist"}} Feb 24 16:07:13 volumio go-librespot[22132]: time="2026-02-24T16:07:13+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 310" Feb 24 16:07:13 volumio go-librespot[22132]: panic: runtime error: invalid memory address or nil pointer dereference Feb 24 16:07:13 volumio go-librespot[22132]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x9132ff] Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 56 gp=0xc000348380 m=0 mp=0x1463040 [running]: Feb 24 16:07:13 volumio go-librespot[22132]: panic({0xba9580?, 0x13f6450?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/panic.go:802 +0x168 fp=0xc0004acac8 sp=0xc0004aca18 pc=0x4889e8 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.panicmem(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/panic.go:262 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.sigpanic() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/signal_unix.go:925 +0x359 fp=0xc0004acb28 sp=0xc0004acac8 pc=0x48afb9 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/player.calculateNormalisationFactor(0x0, 0x26cc40?) Feb 24 16:07:13 volumio go-librespot[22132]: /src/player/player.go:521 +0x1f fp=0xc0004acb50 sp=0xc0004acb28 pc=0x9132ff Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/player.(*Player).NewStream(0xc0000a5480, {0xe0b308, 0xc00026c8c0}, 0xc000261b30, {{0xce4d20, 0x5}, {0xc000554f30, 0x10, 0x10}}, 0x140, ...) Feb 24 16:07:13 volumio go-librespot[22132]: /src/player/player.go:615 +0x1207 fp=0xc0004accd8 sp=0xc0004acb50 pc=0x9149e7 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*AppPlayer).loadCurrentTrack(0xc0000a4600, {0xe0b308, 0xc00026c8c0}, 0x0, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/controls.go:333 +0x769 fp=0xc0004acfc8 sp=0xc0004accd8 pc=0xa2a6c9 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*AppPlayer).handlePlayerCommand(_, {_, _}, {0x1030a9c4, {0xc000147c80, 0x28}, {{0xc0001152b0, 0x8}, {0x0, 0x0}, ...}}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/player.go:243 +0x1a9a fp=0xc0004ad1d8 sp=0xc0004acfc8 pc=0xa350fa Feb 24 16:07:13 volumio go-librespot[22132]: main.(*AppPlayer).handleDealerRequest(_, {_, _}, {0xc0002a6d20, {0xc000146f90, 0x24}, {0x1030a9c4, {0xc000147c80, 0x28}, {{0xc0001152b0, ...}, ...}}}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/player.go:367 +0x1b0 fp=0xc0004ad458 sp=0xc0004ad1d8 pc=0xa35690 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*AppPlayer).Run(0xc0000a4600, {0xe0b228, 0x1483020}, 0xc0002a68c0, 0xc0002a6930) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/player.go:685 +0x7b0 fp=0xc0004adfa8 sp=0xc0004ad458 pc=0xa389f0 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).withAppPlayer.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:274 +0x30 fp=0xc0004adfe0 sp=0xc0004adfa8 pc=0xa31430 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004adfe8 sp=0xc0004adfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by main.(*App).withAppPlayer in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:274 +0x3c5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 1 gp=0xc000002380 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc000045c60?, 0x2?, 0x30?, 0x15?, 0xc000045bfc?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0001e1a70 sp=0xc0001e1a50 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc0001e1c60, 0xc000045bf8, 0x42d2ab?, 0x0, 0xbe7660?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0001e1bb0 sp=0xc0001e1a70 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0xc00027c140, 0xc0001e1d80) Feb 24 16:07:13 volumio go-librespot[22132]: /src/zeroconf/zeroconf.go:283 +0x29a fp=0xc0001e1cf8 sp=0xc0001e1bb0 pc=0x9a379a Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).withAppPlayer(0xc000145200, {0xe0b228, 0x1483020}, 0xc000286880) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:340 +0x590 fp=0xc0001e1e10 sp=0xc0001e1cf8 pc=0xa30810 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).withCredentials(...) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:209 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).SpotifyToken(0xc000145200, {0xe0b228, 0x1483020}, {0xc000148e40?, 0xce6b7b?}, {0xc00011a3c0?, 0x2697?}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:201 +0xc5 fp=0xc0001e1e68 sp=0xc0001e1e10 pc=0xa2fcc5 Feb 24 16:07:13 volumio go-librespot[22132]: main.main() Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:593 +0x745 fp=0xc0001e1f50 sp=0xc0001e1e68 pc=0xa32965 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.main() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:285 +0x29d fp=0xc0001e1fe0 sp=0xc0001e1f50 pc=0x45509d Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001e1fe8 sp=0xc0001e1fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 2 gp=0xc000002e00 m=nil [force gc (idle)]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005afa8 sp=0xc00005af88 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goparkunlock(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.forcegchelper() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:373 +0xb3 fp=0xc00005afe0 sp=0xc00005afa8 pc=0x4553d3 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005afe8 sp=0xc00005afe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.init.7 in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:361 +0x1a Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 3 gp=0xc000003340 m=nil [GC sweep wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x1?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005b780 sp=0xc00005b760 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goparkunlock(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.bgsweep(0xc00007e000) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgcsweep.go:323 +0xdf fp=0xc00005b7c8 sp=0xc00005b780 pc=0x43f29f Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcenable.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:212 +0x25 fp=0xc00005b7e0 sp=0xc00005b7c8 pc=0x4332a5 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005b7e8 sp=0xc00005b7e0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.gcenable in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:212 +0x66 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 4 gp=0xc000003500 m=nil [GC scavenge wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x10000?, 0xdfb480?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005bf78 sp=0xc00005bf58 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goparkunlock(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.(*scavengerState).park(0x1461b00) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x49 fp=0xc00005bfa8 sp=0xc00005bf78 pc=0x43cd29 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.bgscavenge(0xc00007e000) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x59 fp=0xc00005bfc8 sp=0xc00005bfa8 pc=0x43d2d9 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcenable.gowrap2() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:213 +0x25 fp=0xc00005bfe0 sp=0xc00005bfc8 pc=0x433245 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005bfe8 sp=0xc00005bfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.gcenable in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:213 +0xa5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 18 gp=0xc000102000 m=nil [GOMAXPROCS updater (idle)]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000056788 sp=0xc000056768 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goparkunlock(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.updateMaxProcsGoroutine() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:6720 +0xe7 fp=0xc0000567e0 sp=0xc000056788 pc=0x4632c7 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000567e8 sp=0xc0000567e0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:6708 +0x37 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 19 gp=0xc000102540 m=nil [finalizer wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x464295?, 0x42ac45?, 0xb8?, 0x1?, 0xc000002380?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005a620 sp=0xc00005a600 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.runFinalizers() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mfinal.go:210 +0x107 fp=0xc00005a7e0 sp=0xc00005a620 pc=0x4321a7 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005a7e8 sp=0xc00005a7e0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.createfing in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mfinal.go:172 +0x3d Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 20 gp=0xc000103340 m=nil [cleanup wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000056f68 sp=0xc000056f48 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goparkunlock(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:466 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.(*cleanupQueue).dequeue(0x1461f40) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mcleanup.go:439 +0xc5 fp=0xc000056fa0 sp=0xc000056f68 pc=0x42f3c5 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.runCleanups() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mcleanup.go:635 +0x45 fp=0xc000056fe0 sp=0xc000056fa0 pc=0x42fa85 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000056fe8 sp=0xc000056fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mcleanup.go:589 +0xa5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 23 gp=0xc0001036c0 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006fa58 sp=0xc00006fa38 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0xc00006faa8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006fa90 sp=0xc00006fa58 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626e00, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006fab0 sp=0xc00006fa90 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc000198900?, 0x900000036?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006fad8 sp=0xc00006fab0 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Accept(0xc000198900) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00006fb80 sp=0xc00006fad8 pc=0x50fc4c Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).accept(0xc000198900) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00006fc38 sp=0xc00006fb80 pc=0x57c449 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*TCPListener).accept(0xc00012d2c0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00006fc88 sp=0xc00006fc38 pc=0x591bbb Feb 24 16:07:13 volumio go-librespot[22132]: net.(*TCPListener).Accept(0xc00012d2c0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00006fcb8 sp=0xc00006fc88 pc=0x590d90 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*onceCloseListener).Accept(0xc00039c750?) Feb 24 16:07:13 volumio go-librespot[22132]: :1 +0x24 fp=0xc00006fcd0 sp=0xc00006fcb8 pc=0x73aaa4 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*Server).Serve(0xc0000aa000, {0xe0a190, 0xc00012d2c0}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00006fe00 sp=0xc00006fcd0 pc=0x712a0c Feb 24 16:07:13 volumio go-librespot[22132]: net/http.Serve(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2971 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*ConcreteApiServer).serve(0xc00025e3f0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/api_server.go:666 +0x90c fp=0xc00006ffc8 sp=0xc00006fe00 pc=0xa25c4c Feb 24 16:07:13 volumio go-librespot[22132]: main.NewApiServer.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/api_server.go:332 +0x25 fp=0xc00006ffe0 sp=0xc00006ffc8 pc=0xa24985 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006ffe8 sp=0xc00006ffe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by main.NewApiServer in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/api_server.go:332 +0x2ff Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 34 gp=0xc000103880 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc00006dd58?, 0x486a25?, 0xe0?, 0x8e?, 0x87?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006dd28 sp=0xc00006dd08 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006dd60 sp=0xc00006dd28 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626800, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006dd80 sp=0xc00006dd60 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc0000a4500?, 0x7fb43c2825b0?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006dda8 sp=0xc00006dd80 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).RawRead(0xc0000a4500, 0xc00009f2c0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc00006de08 sp=0xc00006dda8 pc=0x5108c5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*rawConn).Read(0xc00005e008, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc00006de40 sp=0xc00006de08 pc=0x58ccf6 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc00007c360, 0xc00032e300, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc00006dea0 sp=0xc00006de40 pc=0x941a85 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0xc0002fc240, {0xc000468000, 0x10000, 0x10000}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv4/payload_cmsg.go:31 +0x225 fp=0xc00006df48 sp=0xc00006dea0 pc=0x945265 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/grandcat/zeroconf.(*Server).recv4(0xc000100240, 0xc0002fc230) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xc7 fp=0xc00006dfc0 sp=0xc00006df48 pc=0x99e627 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x25 fp=0xc00006dfe0 sp=0xc00006dfc0 pc=0x99e2c5 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006dfe8 sp=0xc00006dfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 7 Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x78 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 35 gp=0xc000103a40 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x200000000?, 0x40?, 0x54?, 0xc0002f83a0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006cce0 sp=0xc00006ccc0 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0xe01da0?, 0x1411cb0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00006cd18 sp=0xc00006cce0 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626600, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00006cd38 sp=0xc00006cd18 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc0000a4580?, 0x7fb3f568e000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00006cd60 sp=0xc00006cd38 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).RawRead(0xc0000a4580, 0xc0002d7950) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:710 +0x125 fp=0xc00006cdc0 sp=0xc00006cd60 pc=0x5108c5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*rawConn).Read(0xc00005e0b0, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/rawconn.go:44 +0x36 fp=0xc00006cdf8 sp=0xc00006cdc0 pc=0x58ccf6 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0xc00007c380, 0xc0002fa6c0, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/rawconn_msg.go:27 +0x125 fp=0xc00006ce58 sp=0xc00006cdf8 pc=0x941a85 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/internal/socket/socket.go:247 Feb 24 16:07:13 volumio go-librespot[22132]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0xc0002fc290, {0xc0002d8000, 0x10000, 0x10000}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/golang.org/x/net@v0.48.0/ipv6/payload_cmsg.go:31 +0x265 fp=0xc00006cf48 sp=0xc00006ce58 pc=0x948725 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/grandcat/zeroconf.(*Server).recv6(0xc000100240, 0xc0002fc280) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xc7 fp=0xc00006cfc0 sp=0xc00006cf48 pc=0x99e7e7 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x25 fp=0xc00006cfe0 sp=0xc00006cfc0 pc=0x99e265 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006cfe8 sp=0xc00006cfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 7 Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xd9 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 32 gp=0xc000103c00 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x7b?, 0xc0001dd748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0001dd6f8 sp=0xc0001dd6d8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0001dd730 sp=0xc0001dd6f8 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626c00, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0001dd750 sp=0xc0001dd730 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc000198a00?, 0xc0000e6000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0001dd778 sp=0xc0001dd750 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc000198a00, {0xc0000e6000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0001dd810 sp=0xc0001dd778 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc000198a00, {0xc0000e6000?, 0xc000198a00?, 0xc000140f80?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0001dd858 sp=0xc0001dd810 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc00005e0a8, {0xc0000e6000?, 0x7fb3f5680460?, 0x7fb43c2775c0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0001dd8a0 sp=0xc0001dd858 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*atLeastReader).Read(0xc000357c80, {0xc0000e6000?, 0x0?, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0001dd8e8 sp=0xc0001dd8a0 pc=0x63f87b Feb 24 16:07:13 volumio go-librespot[22132]: bytes.(*Buffer).ReadFrom(0xc0000a2628, {0xe03f40, 0xc000357c80}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0001dd940 sp=0xc0001dd8e8 pc=0x534958 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readFromUntil(0xc0000a2388, {0xe01ea0, 0xc00005e0a8}, 0x450db4?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0001dd978 sp=0xc0001dd940 pc=0x63fa5e Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecordOrCCS(0xc0000a2388, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc0001ddbf0 sp=0xc0001dd978 pc=0x63cadb Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).Read(0xc0000a2388, {0xc0000e7000, 0x1000, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc0001ddc58 sp=0xc0001ddbf0 pc=0x643385 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).Read(0xc0002fa660, {0xc000384200, 0x9, 0x486a45?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc0001ddc90 sp=0xc0001ddc58 pc=0x68e6f7 Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadAtLeast({0xe02280, 0xc0002fa660}, {0xc000384200, 0x9, 0x9}, 0x9) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc0001ddcd8 sp=0xc0001ddc90 pc=0x4c8bae Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadFull(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.http2readFrameHeader({0xc000384200, 0x9, 0xc0001ddd80?}, {0xe02280?, 0xc0002fa660?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc0001ddd28 sp=0xc0001ddcd8 pc=0x6cbd45 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Framer).ReadFrame(0xc0003841c0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc0001dde10 sp=0xc0001ddd28 pc=0x6cc41d Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2clientConnReadLoop).run(0xc0001ddfa8) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc0001ddf60 sp=0xc0001dde10 pc=0x6ef5ba Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2ClientConn).readLoop(0xc0002d4380) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc0001ddfc8 sp=0xc0001ddf60 pc=0x6ee939 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc0001ddfe0 sp=0xc0001ddfc8 pc=0x6e8665 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0001ddfe8 sp=0xc0001ddfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by net/http.(*http2Transport).newClientConn in goroutine 31 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 29 gp=0xc000103dc0 m=nil [GC worker (idle)]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x75061e4e9f0?, 0x0?, 0x50?, 0x48?, 0xc0001048c0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0000bdf38 sp=0xc0000bdf18 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcBgMarkWorker(0xc000104bd0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc0000bdfc8 sp=0xc0000bdf38 pc=0x43598b Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcBgMarkStartWorkers.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc0000bdfe0 sp=0xc0000bdfc8 pc=0x435865 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0000bdfe8 sp=0xc0000bdfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 30 gp=0xc0002d4000 m=nil [GC worker (idle)]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x75061e4fc08?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004c2f38 sp=0xc0004c2f18 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcBgMarkWorker(0xc000104bd0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1463 +0xeb fp=0xc0004c2fc8 sp=0xc0004c2f38 pc=0x43598b Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gcBgMarkStartWorkers.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1373 +0x25 fp=0xc0004c2fe0 sp=0xc0004c2fc8 pc=0x435865 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004c2fe8 sp=0xc0004c2fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/mgc.go:1373 +0x105 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 91 gp=0xc000348000 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc0003e5310?, 0x925374?, 0x45?, 0x66?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0003e52e0 sp=0xc0003e52c0 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0003e5318 sp=0xc0003e52e0 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f44da400, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0003e5338 sp=0xc0003e5318 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc00034cc80?, 0xc0003ae000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0003e5360 sp=0xc0003e5338 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc00034cc80, {0xc0003ae000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0003e53f8 sp=0xc0003e5360 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc00034cc80, {0xc0003ae000?, 0x488f0e?, 0x1?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0003e5440 sp=0xc0003e53f8 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc00005e160, {0xc0003ae000?, 0x2?, 0x45ec3f?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0003e5488 sp=0xc0003e5440 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: io.(*multiReader).Read(0xc000356828, {0xc0003ae000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/multi.go:26 +0x93 fp=0xc0003e54d0 sp=0xc0003e5488 pc=0x4c9a73 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).fill(0xc0002ac420) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:113 +0x103 fp=0xc0003e5508 sp=0xc0003e54d0 pc=0x68e1c3 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).ReadByte(0xc0002ac420) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:273 +0x27 fp=0xc0003e5528 sp=0xc0003e5508 pc=0x68e8e7 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.readFrameHeader(0xc0002ac420, {0xc000487248, 0x8, 0x8}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/frame.go:55 +0x85 fp=0xc0003e55b8 sp=0xc0003e5528 pc=0x84aa65 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).readFrameHeader(0xc0004871e0, {0xe0b1f0, 0x1483020}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:235 +0xd6 fp=0xc0003e56f8 sp=0xc0003e55b8 pc=0x84c6b6 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).readLoop(0xc0004871e0, {0xe0b1f0, 0x1483020}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:193 +0x65 fp=0xc0003e5858 sp=0xc0003e56f8 pc=0x84c025 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).reader(0xc0004871e0, {0xe0b1f0, 0x1483020}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:355 +0x10f fp=0xc0003e5948 sp=0xc0003e5858 pc=0x84d4af Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).Reader(...) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:39 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).Read(0xc00025e468?, {0xe0b1f0?, 0x1483020?}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/read.go:47 +0x1e fp=0xc0003e5978 sp=0xc0003e5948 pc=0x84b67e Feb 24 16:07:13 volumio go-librespot[22132]: main.(*ConcreteApiServer).serve.func17({0xe0a310, 0xc0001e4c30}, 0xc00048a390?) Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/api_server.go:636 +0x3ac fp=0xc0003e5a68 sp=0xc0003e5978 pc=0xa2640c Feb 24 16:07:13 volumio go-librespot[22132]: net/http.HandlerFunc.ServeHTTP(0xc000094000?, {0xe0a310?, 0xc0001e4c30?}, 0x2000000000000?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0003e5a90 sp=0xc0003e5a68 pc=0x70f109 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*ServeMux).ServeHTTP(0xc0000981a0?, {0xe0a310, 0xc0001e4c30}, 0xc000396000) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2861 +0x1c7 fp=0xc0003e5ae0 sp=0xc0003e5a90 pc=0x710fe7 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xe0a310, 0xc0001e4c30}, 0xc000396000) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x164 fp=0xc0003e5b38 sp=0xc0003e5ae0 pc=0xa25e84 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.HandlerFunc.ServeHTTP(0x485cb9?, {0xe0a310?, 0xc0001e4c30?}, 0xc0004c8b68?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2322 +0x29 fp=0xc0003e5b60 sp=0xc0003e5b38 pc=0x70f109 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.serverHandler.ServeHTTP({0xc0000892c0?}, {0xe0a310?, 0xc0001e4c30?}, 0x1?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:3340 +0x8e fp=0xc0003e5b90 sp=0xc0003e5b60 pc=0x72e58e Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*conn).serve(0xc00039c750, {0xe0b260, 0xc0000364e0}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2109 +0x665 fp=0xc0003e5fb8 sp=0xc0003e5b90 pc=0x70d205 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*Server).Serve.gowrap3() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:3493 +0x28 fp=0xc0003e5fe0 sp=0xc0003e5fb8 pc=0x712e08 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0003e5fe8 sp=0xc0003e5fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by net/http.(*Server).Serve in goroutine 23 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:3493 +0x485 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 53 gp=0xc000348540 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x5fb?, 0xc00029f748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00029f6f8 sp=0xc00029f6d8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00029f730 sp=0xc00029f6f8 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626000, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00029f750 sp=0xc00029f730 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc000444b80?, 0xc000285000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00029f778 sp=0xc00029f750 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc000444b80, {0xc000285000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc00029f810 sp=0xc00029f778 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc000444b80, {0xc000285000?, 0xc000444b80?, 0xc0000de600?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc00029f858 sp=0xc00029f810 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc00005e1b0, {0xc000285000?, 0x7fb3f4628950?, 0x7fb43c277108?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc00029f8a0 sp=0xc00029f858 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*atLeastReader).Read(0xc0002f29f0, {0xc000285000?, 0x0?, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc00029f8e8 sp=0xc00029f8a0 pc=0x63f87b Feb 24 16:07:13 volumio go-librespot[22132]: bytes.(*Buffer).ReadFrom(0xc000269428, {0xe03f40, 0xc0002f29f0}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc00029f940 sp=0xc00029f8e8 pc=0x534958 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readFromUntil(0xc000269188, {0xe01ea0, 0xc00005e1b0}, 0x450db4?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc00029f978 sp=0xc00029f940 pc=0x63fa5e Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecordOrCCS(0xc000269188, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc00029fbf0 sp=0xc00029f978 pc=0x63cadb Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).Read(0xc000269188, {0xc0002d3000, 0x1000, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc00029fc58 sp=0xc00029fbf0 pc=0x643385 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).Read(0xc0002afc20, {0xc00017c120, 0x9, 0x486a45?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc00029fc90 sp=0xc00029fc58 pc=0x68e6f7 Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadAtLeast({0xe02280, 0xc0002afc20}, {0xc00017c120, 0x9, 0x9}, 0x9) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc00029fcd8 sp=0xc00029fc90 pc=0x4c8bae Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadFull(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.http2readFrameHeader({0xc00017c120, 0x9, 0xc00029fd80?}, {0xe02280?, 0xc0002afc20?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc00029fd28 sp=0xc00029fcd8 pc=0x6cbd45 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Framer).ReadFrame(0xc00017c0e0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc00029fe10 sp=0xc00029fd28 pc=0x6cc41d Feb 24 16:07:13 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Feb 24 16:07:13 volumio volumio[1165]: info: Connection to go-librespot Websocket closed Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2clientConnReadLoop).run(0xc00029ffa8) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc00029ff60 sp=0xc00029fe10 pc=0x6ef5ba Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2ClientConn).readLoop(0xc000348e00) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc00029ffc8 sp=0xc00029ff60 pc=0x6ee939 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc00029ffe0 sp=0xc00029ffc8 pc=0x6e8665 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00029ffe8 sp=0xc00029ffe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by net/http.(*http2Transport).newClientConn in goroutine 52 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 39 gp=0xc0003488c0 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x5fb?, 0xc0002a0748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0002a06f8 sp=0xc0002a06d8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0002a0730 sp=0xc0002a06f8 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626400, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0002a0750 sp=0xc0002a0730 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc0000a4d80?, 0xc000338000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0002a0778 sp=0xc0002a0750 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc0000a4d80, {0xc000338000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0002a0810 sp=0xc0002a0778 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc0000a4d80, {0xc000338000?, 0xc0000a4d80?, 0xc0003d3800?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0002a0858 sp=0xc0002a0810 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc000116278, {0xc000338000?, 0x7fb3f461efa8?, 0x7fb43c2775c0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0002a08a0 sp=0xc0002a0858 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*atLeastReader).Read(0xc00012a5a0, {0xc000338000?, 0x0?, 0x0?}) Feb 24 16:07:13 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0002a08e8 sp=0xc0002a08a0 pc=0x63f87b Feb 24 16:07:13 volumio go-librespot[22132]: bytes.(*Buffer).ReadFrom(0xc0000a22a8, {0xe03f40, 0xc00012a5a0}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0002a0940 sp=0xc0002a08e8 pc=0x534958 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readFromUntil(0xc0000a2008, {0xe01ea0, 0xc000116278}, 0x450db4?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0002a0978 sp=0xc0002a0940 pc=0x63fa5e Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecordOrCCS(0xc0000a2008, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc0002a0bf0 sp=0xc0002a0978 pc=0x63cadb Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).Read(0xc0000a2008, {0xc000380000, 0x1000, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc0002a0c58 sp=0xc0002a0bf0 pc=0x643385 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).Read(0xc00008b2c0, {0xc0003842e0, 0x9, 0x486a45?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc0002a0c90 sp=0xc0002a0c58 pc=0x68e6f7 Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadAtLeast({0xe02280, 0xc00008b2c0}, {0xc0003842e0, 0x9, 0x9}, 0x9) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc0002a0cd8 sp=0xc0002a0c90 pc=0x4c8bae Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadFull(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.http2readFrameHeader({0xc0003842e0, 0x9, 0xc0002a0d80?}, {0xe02280?, 0xc00008b2c0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc0002a0d28 sp=0xc0002a0cd8 pc=0x6cbd45 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Framer).ReadFrame(0xc0003842a0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc0002a0e10 sp=0xc0002a0d28 pc=0x6cc41d Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2clientConnReadLoop).run(0xc0002a0fa8) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc0002a0f60 sp=0xc0002a0e10 pc=0x6ef5ba Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2ClientConn).readLoop(0xc0002d4540) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc0002a0fc8 sp=0xc0002a0f60 pc=0x6ee939 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc0002a0fe0 sp=0xc0002a0fc8 pc=0x6e8665 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0002a0fe8 sp=0xc0002a0fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by net/http.(*http2Transport).newClientConn in goroutine 38 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 55 gp=0xc000348a80 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc00006bf20?, 0x3?, 0x0?, 0x0?, 0xc00006beda?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00006bd60 sp=0xc00006bd40 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc00006bf20, 0xc00006bed4, 0x0?, 0x0, 0x0?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00006bea0 sp=0xc00006bd60 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0xc0000a5480) Feb 24 16:07:13 volumio go-librespot[22132]: /src/player/player.go:215 +0x205 fp=0xc00006bfc8 sp=0xc00006bea0 pc=0x911e65 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/player/player.go:197 +0x25 fp=0xc00006bfe0 sp=0xc00006bfc8 pc=0x911a25 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00006bfe8 sp=0xc00006bfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/player/player.go:197 +0x1e5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 57 gp=0xc000348c40 m=nil [chan receive]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00029be98 sp=0xc00029be78 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv(0xc000104310, 0xc00029bf98, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc00029bf10 sp=0xc00029be98 pc=0x422773 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv2(0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc00029bf38 sp=0xc00029bf10 pc=0x4222f2 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).withAppPlayer.func1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:284 +0x72 fp=0xc00029bfe0 sp=0xc00029bf38 pc=0xa31372 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00029bfe8 sp=0xc00029bfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by main.(*App).withAppPlayer in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:281 +0x45f Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 58 gp=0xc000348fc0 m=nil [chan receive]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc000059eb8?, 0x0?, 0x40?, 0x8c?, 0xc000059f28?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000059e98 sp=0xc000059e78 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv(0xc0001042a0, 0xc000059fb8, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000059f10 sp=0xc000059e98 pc=0x422773 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv2(0xc000104460?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:514 +0x12 fp=0xc000059f38 sp=0xc000059f10 pc=0x4222f2 Feb 24 16:07:13 volumio go-librespot[22132]: main.(*App).withAppPlayer.func2() Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:300 +0x87 fp=0xc000059fe0 sp=0xc000059f38 pc=0xa30fa7 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000059fe8 sp=0xc000059fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by main.(*App).withAppPlayer in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/cmd/daemon/main.go:297 +0x51f Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 59 gp=0xc000349180 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x0?, 0x0?, 0x0?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00029cbe0 sp=0xc00029cbc0 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0xc00029cc30?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc00029cc18 sp=0xc00029cbe0 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626a00, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc00029cc38 sp=0xc00029cc18 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc0000a4180?, 0x900000036?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc00029cc60 sp=0xc00029cc38 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Accept(0xc0000a4180) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x28c fp=0xc00029cd08 sp=0xc00029cc60 pc=0x50fc4c Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).accept(0xc0000a4180) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_unix.go:161 +0x29 fp=0xc00029cdc0 sp=0xc00029cd08 pc=0x57c449 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*TCPListener).accept(0xc00044dc00) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x1b fp=0xc00029ce10 sp=0xc00029cdc0 pc=0x591bbb Feb 24 16:07:13 volumio go-librespot[22132]: net.(*TCPListener).Accept(0xc00044dc00) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0xc00029ce40 sp=0xc00029ce10 pc=0x590d90 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*onceCloseListener).Accept(0xc00039c990?) Feb 24 16:07:13 volumio go-librespot[22132]: :1 +0x24 fp=0xc00029ce58 sp=0xc00029ce40 pc=0x73aaa4 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*Server).Serve(0xc0000ab000, {0xe0a190, 0xc00044dc00}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:3463 +0x30c fp=0xc00029cf88 sp=0xc00029ce58 pc=0x712a0c Feb 24 16:07:13 volumio go-librespot[22132]: net/http.Serve(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/server.go:2971 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Feb 24 16:07:13 volumio go-librespot[22132]: /src/zeroconf/zeroconf.go:280 +0x85 fp=0xc00029cfe0 sp=0xc00029cf88 pc=0x9a38a5 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00029cfe8 sp=0xc00029cfe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Feb 24 16:07:13 volumio go-librespot[22132]: /src/zeroconf/zeroconf.go:280 +0x156 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 66 gp=0xc000349880 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x0?, 0x64?, 0x58?, 0xb?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000070ae8 sp=0xc000070ac8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc000070b20 sp=0xc000070ae8 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f4626200, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc000070b40 sp=0xc000070b20 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc0000a5200?, 0xc0001156d0?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc000070b68 sp=0xc000070b40 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc0000a5200, {0xc0001156d0, 0x3, 0x3}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc000070c00 sp=0xc000070b68 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc0000a5200, {0xc0001156d0?, 0x7fb43c2775c0?, 0xc00045c008?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc000070c48 sp=0xc000070c00 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc0001162f0, {0xc0001156d0?, 0xc000070cc8?, 0x48b089?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc000070c90 sp=0xc000070c48 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadAtLeast({0xe01ea0, 0xc0001162f0}, {0xc0001156d0, 0x3, 0x3}, 0x3) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc000070cd8 sp=0xc000070c90 pc=0x4c8bae Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadFull(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0xc0003c85a0, {0xe0b228, 0x1483020}) Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/shannon.go:124 +0x37e fp=0xc000070e18 sp=0xc000070cd8 pc=0x8a8d7e Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0xc0001e4b40) Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:289 +0x6c fp=0xc000070fc8 sp=0xc000070e18 pc=0x8a5a0c Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:273 +0x25 fp=0xc000070fe0 sp=0xc000070fc8 pc=0x8a5965 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000070fe8 sp=0xc000070fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 56 Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:273 +0x78 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 65 gp=0xc000349a40 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc00029af40?, 0x5?, 0x48?, 0xaf?, 0xc00029aee6?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00029ad68 sp=0xc00029ad48 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc00029af40, 0xc00029aedc, 0xc00029af48?, 0x0, 0xc0004a0ac0?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00029aea8 sp=0xc00029ad68 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc000486820) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc00029afc8 sp=0xc00029aea8 pc=0x847556 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.newConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc00029afe0 sp=0xc00029afc8 pc=0x847165 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00029afe8 sp=0xc00029afe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by nhooyr.io/websocket.newConn in goroutine 56 Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 67 gp=0xc000349dc0 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc000057f98?, 0x2?, 0x88?, 0xf?, 0xc000057f6c?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000057df8 sp=0xc000057dd8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc000057f98, 0xc000057f68, 0x421301?, 0x0, 0x58a59c?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc000057f38 sp=0xc000057df8 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0xc0001e4b40) Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:368 +0x7d fp=0xc000057fc8 sp=0xc000057f38 pc=0x8a627d Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1.gowrap2() Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:277 +0x25 fp=0xc000057fe0 sp=0xc000057fc8 pc=0x8a5905 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000057fe8 sp=0xc000057fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).startReceiving.func1 in goroutine 56 Feb 24 16:07:13 volumio go-librespot[22132]: /src/ap/ap.go:277 +0xff Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 68 gp=0xc000002000 m=nil [chan receive]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x7fb43c2775c0?, 0xc0002afd40?, 0x8?, 0x10?, 0xc000455b78?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc000045b28 sp=0xc000045b08 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv(0xc0002a6d20, 0xc000455bff, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:667 +0x473 fp=0xc000045ba0 sp=0xc000045b28 pc=0x422773 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.chanrecv1(0xc0003f2000?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/chan.go:509 +0x12 fp=0xc000045bc8 sp=0xc000045ba0 pc=0x4222d2 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0xc00017c1c0, 0xc00039cbd0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/recv.go:237 +0x245 fp=0xc000045e98 sp=0xc000045bc8 pc=0x9304e5 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0xc00017c1c0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:213 +0x388 fp=0xc000045fc8 sp=0xc000045e98 pc=0x92eca8 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:125 +0x25 fp=0xc000045fe0 sp=0xc000045fc8 pc=0x92e505 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc000045fe8 sp=0xc000045fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 56 Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:125 +0x78 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 69 gp=0xc000003a40 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc00005c798?, 0x2?, 0x50?, 0xd?, 0xc00005c744?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc00005c5c8 sp=0xc00005c5a8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc00005c798, 0xc00005c740, 0x0?, 0x0, 0x0?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc00005c708 sp=0xc00005c5c8 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0xc00017c1c0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:138 +0x8f fp=0xc00005c7c8 sp=0xc00005c708 pc=0x92e5cf Feb 24 16:07:13 volumio go-librespot[22132]: github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1.gowrap2() Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:129 +0x25 fp=0xc00005c7e0 sp=0xc00005c7c8 pc=0x92e4a5 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc00005c7e8 sp=0xc00005c7e0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).startReceiving.func1 in goroutine 56 Feb 24 16:07:13 volumio go-librespot[22132]: /src/dealer/dealer.go:129 +0xf6 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 88 gp=0xc0002d4a80 m=nil [IO wait]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0x5fb?, 0xc0004c7748?, 0x3f?, 0xec?, 0xb?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004c76f8 sp=0xc0004c76d8 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.netpollblock(0x4ac5d8?, 0x41f886?, 0x0?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:575 +0xf7 fp=0xc0004c7730 sp=0xc0004c76f8 pc=0x44d977 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.runtime_pollWait(0x7fb3f44da600, 0x72) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/netpoll.go:351 +0x85 fp=0xc0004c7750 sp=0xc0004c7730 pc=0x4880e5 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).wait(0xc000299e80?, 0xc0002b0000?, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27 fp=0xc0004c7778 sp=0xc0004c7750 pc=0x50a827 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*pollDesc).waitRead(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 24 16:07:13 volumio go-librespot[22132]: internal/poll.(*FD).Read(0xc000299e80, {0xc0002b0000, 0x1000, 0x1000}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x279 fp=0xc0004c7810 sp=0xc0004c7778 pc=0x50bb19 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*netFD).Read(0xc000299e80, {0xc0002b0000?, 0xc000299e80?, 0xc0000de600?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/fd_posix.go:68 +0x25 fp=0xc0004c7858 sp=0xc0004c7810 pc=0x57a5a5 Feb 24 16:07:13 volumio go-librespot[22132]: net.(*conn).Read(0xc0001160c8, {0xc0002b0000?, 0x7fb3f4628950?, 0x7fb43c277108?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/net.go:196 +0x45 fp=0xc0004c78a0 sp=0xc0004c7858 pc=0x588ac5 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*atLeastReader).Read(0xc0002f3f20, {0xc0002b0000?, 0x0?, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:816 +0x3b fp=0xc0004c78e8 sp=0xc0004c78a0 pc=0x63f87b Feb 24 16:07:13 volumio go-librespot[22132]: bytes.(*Buffer).ReadFrom(0xc0000be2a8, {0xe03f40, 0xc0002f3f20}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bytes/buffer.go:217 +0x98 fp=0xc0004c7940 sp=0xc0004c78e8 pc=0x534958 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readFromUntil(0xc0000be008, {0xe01ea0, 0xc0001160c8}, 0x450db4?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:838 +0xde fp=0xc0004c7978 sp=0xc0004c7940 pc=0x63fa5e Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecordOrCCS(0xc0000be008, 0x0) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:627 +0x3db fp=0xc0004c7bf0 sp=0xc0004c7978 pc=0x63cadb Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).readRecord(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:589 Feb 24 16:07:13 volumio go-librespot[22132]: crypto/tls.(*Conn).Read(0xc0000be008, {0xc0002b6000, 0x1000, 0x0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x145 fp=0xc0004c7c58 sp=0xc0004c7bf0 pc=0x643385 Feb 24 16:07:13 volumio go-librespot[22132]: bufio.(*Reader).Read(0xc0002ac7e0, {0xc00017c580, 0x9, 0x486a45?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/bufio/bufio.go:245 +0x197 fp=0xc0004c7c90 sp=0xc0004c7c58 pc=0x68e6f7 Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadAtLeast({0xe02280, 0xc0002ac7e0}, {0xc00017c580, 0x9, 0x9}, 0x9) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:335 +0x8e fp=0xc0004c7cd8 sp=0xc0004c7c90 pc=0x4c8bae Feb 24 16:07:13 volumio go-librespot[22132]: io.ReadFull(...) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/io/io.go:354 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.http2readFrameHeader({0xc00017c580, 0x9, 0xc0004c7d80?}, {0xe02280?, 0xc0002ac7e0?}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x65 fp=0xc0004c7d28 sp=0xc0004c7cd8 pc=0x6cbd45 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Framer).ReadFrame(0xc00017c540) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x7d fp=0xc0004c7e10 sp=0xc0004c7d28 pc=0x6cc41d Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2clientConnReadLoop).run(0xc0004c7fa8) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0xda fp=0xc0004c7f60 sp=0xc0004c7e10 pc=0x6ef5ba Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2ClientConn).readLoop(0xc0002d4c40) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x79 fp=0xc0004c7fc8 sp=0xc0004c7f60 pc=0x6ee939 Feb 24 16:07:13 volumio go-librespot[22132]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x25 fp=0xc0004c7fe0 sp=0xc0004c7fc8 pc=0x6e8665 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004c7fe8 sp=0xc0004c7fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by net/http.(*http2Transport).newClientConn in goroutine 87 Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xde5 Feb 24 16:07:13 volumio go-librespot[22132]: goroutine 93 gp=0xc000003dc0 m=nil [select]: Feb 24 16:07:13 volumio go-librespot[22132]: runtime.gopark(0xc0004c8f40?, 0x5?, 0x60?, 0xfc?, 0xc0004c8ee6?) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/proc.go:460 +0xce fp=0xc0004c8d68 sp=0xc0004c8d48 pc=0x488f0e Feb 24 16:07:13 volumio go-librespot[22132]: runtime.selectgo(0xc0004c8f40, 0xc0004c8edc, 0xc0004c8ef0?, 0x0, 0x0?, 0x1) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/select.go:351 +0x8b7 fp=0xc0004c8ea8 sp=0xc0004c8d68 pc=0x467bd7 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.(*Conn).timeoutLoop(0xc0004871e0) Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:180 +0x196 fp=0xc0004c8fc8 sp=0xc0004c8ea8 pc=0x847556 Feb 24 16:07:13 volumio go-librespot[22132]: nhooyr.io/websocket.newConn.gowrap1() Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x25 fp=0xc0004c8fe0 sp=0xc0004c8fc8 pc=0x847165 Feb 24 16:07:13 volumio go-librespot[22132]: runtime.goexit({}) Feb 24 16:07:13 volumio go-librespot[22132]: /usr/local/go/src/runtime/asm_amd64.s:1693 +0x1 fp=0xc0004c8fe8 sp=0xc0004c8fe0 pc=0x490a41 Feb 24 16:07:13 volumio go-librespot[22132]: created by nhooyr.io/websocket.newConn in goroutine 91 Feb 24 16:07:13 volumio go-librespot[22132]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.17/conn.go:140 +0x4c8 Feb 24 16:07:13 volumio go-librespot[22131]: Aborted Feb 24 16:07:14 volumio volumio[1165]: info: Getting Spotify volume Feb 24 16:07:14 volumio volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 16:07:14 volumio volumio[1165]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 24 16:07:14 volumio volumio[1165]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 24 16:07:14 volumio volumio[1165]: errno: -111, Feb 24 16:07:14 volumio volumio[1165]: code: 'ECONNREFUSED', Feb 24 16:07:14 volumio volumio[1165]: syscall: 'connect', Feb 24 16:07:14 volumio volumio[1165]: address: '127.0.0.1', Feb 24 16:07:14 volumio volumio[1165]: port: 9879, Feb 24 16:07:14 volumio volumio[1165]: response: undefined Feb 24 16:07:14 volumio volumio[1165]: } Feb 24 16:07:14 volumio volumio[1165]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 24 16:07:14 volumio sudo[22162]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-24 16:06' Feb 24 16:07:14 volumio sudo[22162]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:38:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="00e933ebe3692ad8aea9910d2289bf23"