Dec 08 21:14:01 volumio go-librespot[1540]: time="2025-12-08T21:14:01+01:00" level=debug msg="fetched chunk 4/12, size: 524288" uri="spotify:track:2OdlgBxPLUh0BjXf0jRYDc" Dec 08 21:14:04 volumio volumio[1270]: info: CoreCommandRouter::volumioNext Dec 08 21:14:04 volumio volumio[1270]: info: CoreStateMachine::next Dec 08 21:14:04 volumio volumio[1270]: info: Spotify next Dec 08 21:14:04 volumio volumio[1270]: info: Sending Spotify command to local API: /player/next Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="emitting websocket event: will_play" Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:playlist:37i9dQZF1E4y6uD8rAok6k","uri":"spotify:track:42O31gY8N28p4DAk7YYkeM","play_origin":"playlist"}} Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="selected format OGG_VORBIS_320 (d2a8cce53f4d10cec72d3a70ddfa44bc6852758e)" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="requested aes key for file d2a8cce53f4d10cec72d3a70ddfa44bc6852758e, gid: 42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="found 2 cdn urls" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="fetched first chunk of 13, total size is 6459508 bytes" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=info msg="loaded track \"Get Shaky (Macon's Remix)\" (paused: false, position: 1ms, duration: 150204ms, prefetched: false)" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="fetched chunk 2/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="fetched chunk 1/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="fetched chunk 3/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="scheduling prefetch in 120s" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="emitting websocket event: metadata" Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:42O31gY8N28p4DAk7YYkeM","name":"Get Shaky (Macon's Remix)","artist_names":["The Ian Carey Project","Macon"],"album_name":"Get Shaky (Macon's Remix)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02d51f23ca7fad40f20ed2120f","position":1,"duration":150204,"release_date":"year:2023 month:4 day:14","track_number":1,"disc_number":1}} Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 08 21:14:04 volumio go-librespot[1540]: time="2025-12-08T21:14:04+01:00" level=trace msg="emitting websocket event: playing" Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:playlist:37i9dQZF1E4y6uD8rAok6k","uri":"spotify:track:42O31gY8N28p4DAk7YYkeM","resume":false,"play_origin":"playlist"}} Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: PUSH STATE SPOTIFY Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: {"status":"play","service":"spop","title":"Get Shaky (Macon's Remix)","artist":"The Ian Carey Project, Macon","album":"Get Shaky (Macon's Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02d51f23ca7fad40f20ed2120f","uri":"spotify:track:42O31gY8N28p4DAk7YYkeM","trackType":"spotify","seek":1,"duration":150,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 08 21:14:04 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 08 21:14:04 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 08 21:14:04 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 08 21:14:04 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 08 21:14:04 volumio volumio[1270]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 08 21:14:05 volumio volumio[1270]: SPOTIFY: PUSH STATE SPOTIFY Dec 08 21:14:05 volumio volumio[1270]: SPOTIFY: {"status":"play","service":"spop","title":"Get Shaky (Macon's Remix)","artist":"The Ian Carey Project, Macon","album":"Get Shaky (Macon's Remix)","albumart":"https://i.scdn.co/image/ab67616d00001e02d51f23ca7fad40f20ed2120f","uri":"spotify:track:42O31gY8N28p4DAk7YYkeM","trackType":"spotify","seek":1001,"duration":150,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Dec 08 21:14:05 volumio volumio[1270]: info: CoreCommandRouter::servicePushState Dec 08 21:14:05 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 08 21:14:05 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 08 21:14:05 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 08 21:14:05 volumio volumio[1270]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 08 21:14:09 volumio ntpd[1010]: PROTO: 144.91.126.59 unlink local addr 192.168.0.133 -> Dec 08 21:14:15 volumio go-librespot[1540]: time="2025-12-08T21:14:15+01:00" level=trace msg="received accesspoint ping" Dec 08 21:14:15 volumio go-librespot[1540]: time="2025-12-08T21:14:15+01:00" level=trace msg="received accesspoint pong ack" Dec 08 21:14:15 volumio go-librespot[1540]: time="2025-12-08T21:14:15+01:00" level=trace msg="sent dealer ping" Dec 08 21:14:16 volumio go-librespot[1540]: time="2025-12-08T21:14:16+01:00" level=trace msg="received dealer pong" Dec 08 21:14:16 volumio go-librespot[1540]: time="2025-12-08T21:14:16+01:00" level=debug msg="fetched chunk 4/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:23 volumio nmbd[1070]: [2025/12/08 21:14:23.883327, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 08 21:14:23 volumio nmbd[1070]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.133 for name WORKGROUP<1d>. Dec 08 21:14:23 volumio nmbd[1070]: This response was from IP 192.168.0.40, reporting an IP address of 192.168.0.40. Dec 08 21:14:28 volumio go-librespot[1540]: time="2025-12-08T21:14:28+01:00" level=debug msg="fetched chunk 5/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:33 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 08 21:14:33 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 08 21:14:36 volumio volumio[1270]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 08 21:14:41 volumio go-librespot[1540]: time="2025-12-08T21:14:41+01:00" level=debug msg="fetched chunk 6/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:45 volumio go-librespot[1540]: time="2025-12-08T21:14:45+01:00" level=trace msg="sent dealer ping" Dec 08 21:14:46 volumio go-librespot[1540]: time="2025-12-08T21:14:46+01:00" level=trace msg="received dealer pong" Dec 08 21:14:46 volumio volumio[1270]: info: CorePlayQueue::getTrack 8 Dec 08 21:14:46 volumio volumio[1270]: info: CorePlayQueue::getTrack 9 Dec 08 21:14:46 volumio volumio[1270]: info: Prefetching next song Dec 08 21:14:46 volumio volumio[1270]: info: [1765224886236] ControllerSpotify::prefetch Dec 08 21:14:46 volumio volumio[1270]: info: Sending Spotify command with payload to local API: /player/add_to_queue Dec 08 21:14:46 volumio go-librespot[1540]: time="2025-12-08T21:14:46+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Dec 08 21:14:46 volumio go-librespot[1540]: time="2025-12-08T21:14:46+01:00" level=trace msg="scheduling prefetch in 78s" Dec 08 21:14:50 volumio volumio[1270]: info: CoreStateMachine::startPlaybackTimer Dec 08 21:14:50 volumio volumio[1270]: info: CorePlayQueue::getTrack 9 Dec 08 21:14:51 volumio volumio[1270]: info: CoreStateMachine::pushState Dec 08 21:14:51 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 08 21:14:51 volumio volumio[1270]: info: CoreCommandRouter::volumioPushState Dec 08 21:14:51 volumio volumio[1270]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 08 21:14:52 volumio go-librespot[1540]: time="2025-12-08T21:14:52+01:00" level=debug msg="fetched chunk 7/12, size: 524288" uri="spotify:track:42O31gY8N28p4DAk7YYkeM" Dec 08 21:14:57 volumio volumio[1270]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Dec 08 21:14:57 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Dec 08 21:14:57 volumio volumio[1270]: info: Creating Spotify config file Dec 08 21:14:57 volumio volumio[1270]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 21:14:57 volumio volumio[1270]: info: Spotify config file written Dec 08 21:14:57 volumio sudo[4749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 08 21:14:57 volumio sudo[4749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 08 21:14:57 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 08 21:14:57 volumio systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 08 21:14:57 volumio systemd[1]: go-librespot-daemon.service: Killing process 2176 (go-librespot) with signal SIGKILL. Dec 08 21:14:57 volumio systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 08 21:14:57 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 08 21:14:57 volumio systemd[1]: go-librespot-daemon.service: Consumed 38.476s CPU time. Dec 08 21:14:57 volumio volumio[1270]: info: Connection to go-librespot Websocket closed Dec 08 21:14:57 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 08 21:14:57 volumio go-librespot[4761]: go-librespot daemon starting... Dec 08 21:14:57 volumio sudo[4749]: pam_unix(sudo:session): session closed for user root Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=info msg="running go-librespot 0.4.0" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=debug msg="app state loaded" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+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-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=info msg="zeroconf server listening on port 34287" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=debug msg="obtained new client token: AAA41j1Yq4Cv/2uwjTSFDuS16ZNI0ZyyBV61DZIqqI2UojDBlSzs3mrPHHGf0+htyS/lbcnpkiQ4Xm49oK2aAl2VMRX8JotrbJ1FyKr5CotFYpwEjmddNsHDqf122TV6R5i2lsgLziltup1NmpDVmDsR/DKG9+TMdVzOZqbwKiFunKyg9rau34/T4Wb4DXpDjSA/ucrhX+CIyWl8+b8E57ux3k2MvajYLX5w9TOrje0UBgcWyvGFsfw=" Dec 08 21:14:57 volumio go-librespot[4763]: time="2025-12-08T21:14:57+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 08 21:14:57 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 08 21:14:57 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 08 21:14:58 volumio go-librespot[4763]: time="2025-12-08T21:14:58+01:00" level=debug msg="completed keyexchange" Dec 08 21:14:58 volumio go-librespot[4763]: time="2025-12-08T21:14:58+01:00" level=debug msg="completed challenge" Dec 08 21:14:58 volumio go-librespot[4763]: time="2025-12-08T21:14:58+01:00" level=info msg="authenticated AP" username="sc*******21" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=info msg="authenticated Login5" username="sc*******21" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="initializing zeroconf session" username="sc*******21" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="dealer connection opened" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=trace msg="starting accesspoint recv loop" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=trace msg="starting dealer recv loop" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=trace msg="received accesspoint ping" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="received connection id: NTM4N2QzZWQtOGQw...RTY0MTEyMDgyMQ==" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=trace msg="received accesspoint pong ack" Dec 08 21:14:59 volumio go-librespot[4763]: time="2025-12-08T21:14:59+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 08 21:15:00 volumio volumio[1270]: info: Initializing connection to go-librespot Websocket Dec 08 21:15:00 volumio go-librespot[4763]: time="2025-12-08T21:15:00+01:00" level=debug msg="new websocket client" Dec 08 21:15:00 volumio volumio[1270]: info: Connection to go-librespot Websocket established Dec 08 21:15:00 volumio volumio[1270]: info: go-librespot daemon successfully initialized Dec 08 21:15:03 volumio volumio[1270]: info: Getting Spotify volume Dec 08 21:15:03 volumio volumio[1270]: info: Initializing connection to go-librespot Websocket Dec 08 21:15:03 volumio volumio[1270]: info: Spotify volume: 100 Dec 08 21:15:03 volumio go-librespot[4763]: time="2025-12-08T21:15:03+01:00" level=debug msg="new websocket client" Dec 08 21:15:03 volumio volumio[1270]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 08 21:15:03 volumio volumio[1270]: info: Connection to go-librespot Websocket established Dec 08 21:15:03 volumio volumio[1270]: info: CoreCommandRouter::volumioGetState Dec 08 21:15:03 volumio volumio[1270]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 08 21:15:05 volumio volumio[1270]: info: CoreCommandRouter::volumioNext Dec 08 21:15:05 volumio volumio[1270]: info: CoreStateMachine::next Dec 08 21:15:05 volumio volumio[1270]: info: Spotify next Dec 08 21:15:05 volumio volumio[1270]: info: Sending Spotify command to local API: /player/next Dec 08 21:15:05 volumio go-librespot[4763]: panic: runtime error: invalid memory address or nil pointer dereference Dec 08 21:15:05 volumio go-librespot[4763]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x20 pc=0x517804] Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 61 gp=0x2f707e8 m=7 mp=0x2c82688 [running]: Dec 08 21:15:05 volumio go-librespot[4763]: panic({0x6cfb00, 0xca02c0}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x2d87568 sp=0x2d87514 pc=0x58bf8 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.panicmem(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/panic.go:261 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.sigpanic() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/signal_unix.go:881 +0x39c fp=0x2d87598 sp=0x2d87568 pc=0x74be4 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/tracks.(*List).AllTracks(0x0, {0x8874f0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/tracks/tracks.go:78 +0x14 fp=0x2d875f8 sp=0x2d8759c pc=0x517804 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*AppPlayer).advanceNext(0x2e26870, {0x8874f0, 0xd0ad00}, 0x1, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/controls.go:604 +0x3cc fp=0x2d876b8 sp=0x2d875f8 pc=0x63aef0 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*AppPlayer).skipNext(0x2e26870, {0x8874f0, 0xd0ad00}, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/controls.go:545 +0x4dc fp=0x2d87754 sp=0x2d876b8 pc=0x63a978 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*AppPlayer).handleApiRequest(0x2e26870, {0x8874f0, 0xd0ad00}, {{0x791346, 0x4}, {0x6c9bb0, 0x0}, 0x2e86940}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/player.go:478 +0x12c fp=0x2d878e4 sp=0x2d87754 pc=0x643810 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*AppPlayer).Run(0x2e26870, {0x8874f0, 0xd0ad00}, 0x2edce40) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/player.go:610 +0x864 fp=0x2d87fd8 sp=0x2d878e4 pc=0x645db0 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).withAppPlayer.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:258 +0x40 fp=0x2d87fec sp=0x2d87fd8 pc=0x63e874 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2d87fec sp=0x2d87fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by main.(*App).withAppPlayer in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:258 +0x3d8 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 1 gp=0x2c02128 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2debd00 sp=0x2debcec pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2debe00, 0x2d85dcc, 0x0, 0x0, 0x2, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2debda0 sp=0x2debd00 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x2c28ae0, 0x2debe90) Dec 08 21:15:05 volumio go-librespot[4763]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x2debe44 sp=0x2debda0 pc=0x5a8088 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).withAppPlayer(0x2cc6c00, {0x8874f0, 0xd0ad00}, 0x2cab530) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:321 +0x554 fp=0x2debed0 sp=0x2debe44 pc=0x63db54 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).withCredentials(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:193 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).SpotifyToken(0x2cc6c00, {0x8874f0, 0xd0ad00}, {0x2caef80, 0xb}, {0x2ca43c0, 0x126}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:185 +0xd8 fp=0x2debf00 sp=0x2debed0 pc=0x63cfa8 Dec 08 21:15:05 volumio go-librespot[4763]: main.main() Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:557 +0x588 fp=0x2debfa8 sp=0x2debf00 pc=0x63feb4 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.main() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x2debfec sp=0x2debfa8 pc=0x5cb30 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2debfec sp=0x2debfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 2 gp=0x2c027e8 m=nil [force gc (idle)]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c44fd4 sp=0x2c44fc0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goparkunlock(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:408 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.forcegchelper() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x2c44fec sp=0x2c44fd4 pc=0x5cefc Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c44fec sp=0x2c44fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.init.5 in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:314 +0x1c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 18 gp=0x2c84248 m=nil [GC sweep wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c407c4 sp=0x2c407b0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goparkunlock(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:408 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.bgsweep(0x2c90000) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x2c407e4 sp=0x2c407c4 pc=0x45848 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcenable.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x2c407ec sp=0x2c407e4 pc=0x35968 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c407ec sp=0x2c407ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcenable in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 19 gp=0x2c84368 m=nil [GC scavenge wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c40fb4 sp=0x2c40fa0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goparkunlock(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:408 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.(*scavengerState).park(0xce0208) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2c40fc8 sp=0x2c40fb4 pc=0x42b68 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.bgscavenge(0x2c90000) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x2c40fe4 sp=0x2c40fc8 pc=0x432a0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcenable.gowrap2() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x2c40fec sp=0x2c40fe4 pc=0x35914 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c40fec sp=0x2c40fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcenable in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 20 gp=0x2c846c8 m=nil [finalizer wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c4178c sp=0x2c41778 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.runfinq() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x2c417ec sp=0x2c4178c pc=0x34754 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c417ec sp=0x2c417ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.createfing in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 23 gp=0x2c85d48 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3f08, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c41d28 sp=0x2c41d14 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3ef8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2c41d40 sp=0x2c41d28 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3ef8, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2c41d54 sp=0x2c41d40 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2ca7418, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2c41d68 sp=0x2c41d54 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Accept(0x2ca7400) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x2c41db0 sp=0x2c41d68 pc=0x10eb84 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).accept(0x2ca7400) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x2c41e18 sp=0x2c41db0 pc=0x17e4c4 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPListener).accept(0x2cb2828) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2c41e30 sp=0x2c41e18 pc=0x196900 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPListener).Accept(0x2cb2828) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x2c41e4c sp=0x2c41e30 pc=0x19596c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*onceCloseListener).Accept(0x2c7e340) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x34 fp=0x2c41e64 sp=0x2c41e4c pc=0x362b54 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*Server).Serve(0x2c780a8, {0x886cb8, 0x2cb2828}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x2c41efc sp=0x2c41e64 pc=0x341210 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.Serve(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2794 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve(0x2cacf60) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x2c41fe4 sp=0x2c41efc pc=0x6330b8 Dec 08 21:15:05 volumio go-librespot[4763]: main.NewApiServer.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x2c41fec sp=0x2c41fe4 pc=0x631de4 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c41fec sp=0x2c41fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by main.NewApiServer in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:296 +0x310 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 101 gp=0x2dd4008 m=nil [chan receive]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3f90, 0x2e86970, 0xe, 0x7, 0x2) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dcebb0 sp=0x2dceb9c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv(0x2e86940, 0x2dcec7c, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x2dcebec sp=0x2dcebb0 pc=0x20078 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv1(0x2e86940, 0x2dcec7c) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x2dcec00 sp=0x2dcebec pc=0x1fb98 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).handleRequest(0x2cacf60, {{0x791346, 0x4}, {0x6c9bb0, 0x0}, 0x2e86940}, {0x886dec, 0x2c78e68}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:319 +0x74 fp=0x2dcec8c sp=0x2dcec00 pc=0x631f94 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.func8({0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:450 +0x12c fp=0x2dceccc sp=0x2dcec8c pc=0x6347cc Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c300b8, {0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dcecdc sp=0x2dceccc pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*ServeMux).ServeHTTP(0x2c74000, {0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x2dced18 sp=0x2dcecdc pc=0x33f654 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x2dced40 sp=0x2dced18 pc=0x633388 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c0e190, {0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dced50 sp=0x2dced40 pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.serverHandler.ServeHTTP({0x2c780a8}, {0x886dec, 0x2c78e68}, 0x2db00a8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x2dced6c sp=0x2dced50 pc=0x340de4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*conn).serve(0x2c28180, {0x887510, 0x2c26198}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x2dcefdc sp=0x2dced6c pc=0x33c034 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*Server).Serve.gowrap3() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x2dcefec sp=0x2dcefdc pc=0x341688 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2dcefec sp=0x2dcefec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*Server).Serve in goroutine 23 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x468 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 9 gp=0x2dd4128 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3e68, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2df0ad4 sp=0x2df0ac0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3e58, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2df0aec sp=0x2df0ad4 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3e58, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2df0b00 sp=0x2df0aec pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2ca75a8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2df0b14 sp=0x2df0b00 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2ca7590, {0x2e1e000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2df0b5c sp=0x2df0b14 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2ca7590, {0x2e1e000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2df0b88 sp=0x2df0b5c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2c30200, {0x2e1e000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2df0bb4 sp=0x2df0b88 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2c30200, {0x2e1e000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2df0bd4 sp=0x2df0bb4 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*atLeastReader).Read(0x30c2620, {0x2e1e000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x2df0c00 sp=0x2df0bd4 pc=0x27c680 Dec 08 21:15:05 volumio go-librespot[4763]: bytes.(*Buffer).ReadFrom(0x2e0a18c, {0x883674, 0x30c2620}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x2df0c3c sp=0x2df0c00 pc=0x139bd0 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readFromUntil(0x2e0a008, {0x882848, 0x2c30200}, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x2df0c64 sp=0x2df0c3c pc=0x27c8dc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecordOrCCS(0x2e0a008, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x2df0dc8 sp=0x2df0c64 pc=0x279fdc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecord(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).Read(0x2e0a008, {0x2e1f000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x2df0df8 sp=0x2df0dc8 pc=0x27fe4c Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).Read(0x2c01e60, {0x2cc6824, 0x9, 0x9}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x2df0e1c sp=0x2df0df8 pc=0x2be440 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadAtLeast({0x882a3c, 0x2c01e60}, {0x2cc6824, 0x9, 0x9}, 0x9) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2df0e48 sp=0x2df0e1c pc=0x1042c0 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadFull(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:354 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.http2readFrameHeader({0x2cc6824, 0x9, 0x9}, {0x882a3c, 0x2c01e60}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x2df0e70 sp=0x2df0e48 pc=0x2f733c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Framer).ReadFrame(0x2cc6800) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x2df0eec sp=0x2df0e70 pc=0x2f7ad4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2clientConnReadLoop).run(0x2df0fdc) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x2df0fa4 sp=0x2df0eec pc=0x31c2f0 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2ClientConn).readLoop(0x2cf1d08) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x2df0fe4 sp=0x2df0fa4 pc=0x31b7e4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x2df0fec sp=0x2df0fe4 pc=0x314830 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2df0fec sp=0x2df0fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*http2Transport).newClientConn in goroutine 8 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 5 gp=0x2c02fc8 m=nil [GC worker (idle)]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3fbc, 0x2f45368, 0x1a, 0xa, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c45790 sp=0x2c4577c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcBgMarkWorker() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x2c457ec sp=0x2c45790 pc=0x38590 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c457ec sp=0x2c457ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 6 gp=0x2c030e8 m=nil [GC worker (idle)]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3fbc, 0x2cbe720, 0x1a, 0xa, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c45f90 sp=0x2c45f7c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcBgMarkWorker() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x2c45fec sp=0x2c45f90 pc=0x38590 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c45fec sp=0x2c45fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 29 gp=0x2dd4488 m=nil [GC worker (idle)]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3fbc, 0x2f45380, 0x1a, 0xa, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c42790 sp=0x2c4277c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcBgMarkWorker() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x2c427ec sp=0x2c42790 pc=0x38590 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c427ec sp=0x2c427ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 7 gp=0x2c03208 m=nil [GC worker (idle)]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3fbc, 0x2cbe738, 0x1a, 0xa, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c46790 sp=0x2c4677c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gcBgMarkWorker() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x2c467ec sp=0x2c46790 pc=0x38590 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c467ec sp=0x2c467ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by runtime.gcBgMarkStartWorkers in goroutine 3 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 30 gp=0x2c02ea8 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3d28, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dece84 sp=0x2dece70 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3d18, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dece9c sp=0x2dece84 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3d18, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2deceb0 sp=0x2dece9c pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e267e8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2decec4 sp=0x2deceb0 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).RawRead(0x2e267d0, 0x2f82210) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x2decef0 sp=0x2decec4 pc=0x10f788 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*rawConn).Read(0x30b8838, 0x2f82210) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x2decf10 sp=0x2decef0 pc=0x190d28 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x30c27a0, 0x2f821e0, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x2decf40 sp=0x2decf10 pc=0x548824 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x30660c8, {0x2db2000, 0x10000, 0x10000}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x2decf9c sp=0x2decf40 pc=0x54c80c Dec 08 21:15:05 volumio go-librespot[4763]: github.com/grandcat/zeroconf.(*Server).recv4(0x2fe7240, 0x30660c0) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x2decfe0 sp=0x2decf9c pc=0x5a309c Dec 08 21:15:05 volumio go-librespot[4763]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x2decfec sp=0x2decfe0 pc=0x5a2d54 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2decfec sp=0x2decfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 11 Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 31 gp=0x2c03328 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3c88, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x305965c sp=0x3059648 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3c78, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x3059674 sp=0x305965c pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3c78, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x3059688 sp=0x3059674 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e26838, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x305969c sp=0x3059688 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).RawRead(0x2e26820, 0x2df2030) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x30596c8 sp=0x305969c pc=0x10f788 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*rawConn).Read(0x30b8860, 0x2df2030) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x30596e8 sp=0x30596c8 pc=0x190d28 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x30c27b0, 0x2df2000, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x3059718 sp=0x30596e8 pc=0x548824 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Dec 08 21:15:05 volumio go-librespot[4763]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x30660f8, {0x2d9c000, 0x10000, 0x10000}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x305979c sp=0x3059718 pc=0x550194 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/grandcat/zeroconf.(*Server).recv6(0x2fe7240, 0x30660f0) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x30597e0 sp=0x305979c pc=0x5a3290 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x30597ec sp=0x30597e0 pc=0x5a2cf8 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x30597ec sp=0x30597ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 11 Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 36 gp=0x2dd5448 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3be8, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dcfad4 sp=0x2dcfac0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3bd8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dcfaec sp=0x2dcfad4 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3bd8, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2dcfb00 sp=0x2dcfaec pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e34338, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2dcfb14 sp=0x2dcfb00 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2e34320, {0x2e4c000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2dcfb5c sp=0x2dcfb14 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2e34320, {0x2e4c000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2dcfb88 sp=0x2dcfb5c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2d8c048, {0x2e4c000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2dcfbb4 sp=0x2dcfb88 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2d8c048, {0x2e4c000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2dcfbd4 sp=0x2dcfbb4 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*atLeastReader).Read(0x30c3090, {0x2e4c000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x2dcfc00 sp=0x2dcfbd4 pc=0x27c680 Dec 08 21:15:05 volumio go-librespot[4763]: bytes.(*Buffer).ReadFrom(0x2d9818c, {0x883674, 0x30c3090}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x2dcfc3c sp=0x2dcfc00 pc=0x139bd0 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readFromUntil(0x2d98008, {0x882848, 0x2d8c048}, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x2dcfc64 sp=0x2dcfc3c pc=0x27c8dc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecordOrCCS(0x2d98008, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x2dcfdc8 sp=0x2dcfc64 pc=0x279fdc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecord(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).Read(0x2d98008, {0x2e58000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x2dcfdf8 sp=0x2dcfdc8 pc=0x27fe4c Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).Read(0x3067560, {0x2cc6e24, 0x9, 0x9}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x2dcfe1c sp=0x2dcfdf8 pc=0x2be440 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadAtLeast({0x882a3c, 0x3067560}, {0x2cc6e24, 0x9, 0x9}, 0x9) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2dcfe48 sp=0x2dcfe1c pc=0x1042c0 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadFull(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:354 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.http2readFrameHeader({0x2cc6e24, 0x9, 0x9}, {0x882a3c, 0x3067560}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x2dcfe70 sp=0x2dcfe48 pc=0x2f733c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Framer).ReadFrame(0x2cc6e00) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x2dcfeec sp=0x2dcfe70 pc=0x2f7ad4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2clientConnReadLoop).run(0x2dcffdc) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x2dcffa4 sp=0x2dcfeec pc=0x31c2f0 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2ClientConn).readLoop(0x2cf1f08) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x2dcffe4 sp=0x2dcffa4 pc=0x31b7e4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x2dcffec sp=0x2dcffe4 pc=0x314830 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2dcffec sp=0x2dcffec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*http2Transport).newClientConn in goroutine 35 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 72 gp=0x2c84908 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3b48, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dead14 sp=0x2dead00 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3b38, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dead2c sp=0x2dead14 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3b38, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2dead40 sp=0x2dead2c pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2f0eb58, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2dead54 sp=0x2dead40 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2f0eb40, {0x2f06020, 0x3, 0x3}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2dead9c sp=0x2dead54 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2f0eb40, {0x2f06020, 0x3, 0x3}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2deadc8 sp=0x2dead9c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2ebe0b8, {0x2f06020, 0x3, 0x3}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2deadf4 sp=0x2deadc8 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2ebe0b8, {0x2f06020, 0x3, 0x3}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2deae14 sp=0x2deadf4 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadAtLeast({0x882848, 0x2ebe0b8}, {0x2f06020, 0x3, 0x3}, 0x3) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2deae40 sp=0x2deae14 pc=0x1042c0 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadFull(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:354 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x2c97b80, {0x8874f0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/shannon.go:124 +0x3a0 fp=0x2deaf04 sp=0x2deae40 pc=0x48faf4 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x2f22008) Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:276 +0x68 fp=0x2deafe4 sp=0x2deaf04 pc=0x48c330 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:260 +0x28 fp=0x2deafec sp=0x2deafe4 pc=0x48c29c Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2deafec sp=0x2deafec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 61 Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:260 +0x98 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 41 gp=0x2f705a8 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3aa8, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dedad4 sp=0x2dedac0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3a98, 0x72, 0x0) Dec 08 21:15:05 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Dec 08 21:15:05 volumio volumio[1270]: error: Failed to send command to Spotify local API: /player/next: Error: socket hang up Dec 08 21:15:05 volumio volumio[1270]: info: Connection to go-librespot Websocket closed Dec 08 21:15:05 volumio volumio[1270]: info: Connection to go-librespot Websocket closed Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dedaec sp=0x2dedad4 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3a98, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2dedb00 sp=0x2dedaec pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2f63d78, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2dedb14 sp=0x2dedb00 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2f63d60, {0x2e59000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2dedb5c sp=0x2dedb14 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2f63d60, {0x2e59000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2dedb88 sp=0x2dedb5c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x30b8f90, {0x2e59000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2dedbb4 sp=0x2dedb88 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x30b8f90, {0x2e59000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2dedbd4 sp=0x2dedbb4 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*atLeastReader).Read(0x30c3270, {0x2e59000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x2dedc00 sp=0x2dedbd4 pc=0x27c680 Dec 08 21:15:05 volumio go-librespot[4763]: bytes.(*Buffer).ReadFrom(0x2e0ba4c, {0x883674, 0x30c3270}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x2dedc3c sp=0x2dedc00 pc=0x139bd0 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readFromUntil(0x2e0b8c8, {0x882848, 0x30b8f90}, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x2dedc64 sp=0x2dedc3c pc=0x27c8dc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecordOrCCS(0x2e0b8c8, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x2deddc8 sp=0x2dedc64 pc=0x279fdc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecord(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).Read(0x2e0b8c8, {0x2f8d000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x2deddf8 sp=0x2deddc8 pc=0x27fe4c Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).Read(0x2f82750, {0x2cc6ea4, 0x9, 0x9}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x2dede1c sp=0x2deddf8 pc=0x2be440 Dec 08 21:15:05 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadAtLeast({0x882a3c, 0x2f82750}, {0x2cc6ea4, 0x9, 0x9}, 0x9) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2dede48 sp=0x2dede1c pc=0x1042c0 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadFull(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:354 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.http2readFrameHeader({0x2cc6ea4, 0x9, 0x9}, {0x882a3c, 0x2f82750}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x2dede70 sp=0x2dede48 pc=0x2f733c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Framer).ReadFrame(0x2cc6e80) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x2dedeec sp=0x2dede70 pc=0x2f7ad4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2clientConnReadLoop).run(0x2dedfdc) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x2dedfa4 sp=0x2dedeec pc=0x31c2f0 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2ClientConn).readLoop(0x2f8a008) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x2dedfe4 sp=0x2dedfa4 pc=0x31b7e4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x2dedfec sp=0x2dedfe4 pc=0x314830 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2dedfec sp=0x2dedfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*http2Transport).newClientConn in goroutine 40 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 60 gp=0x2f706c8 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f7b674 sp=0x2f7b660 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2f7b774, 0x2f7b73c, 0x0, 0x0, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2f7b714 sp=0x2f7b674 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x2f7eb40) Dec 08 21:15:05 volumio go-librespot[4763]: /src/player/player.go:201 +0x1fc fp=0x2f7b7e4 sp=0x2f7b714 pc=0x513660 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/player/player.go:183 +0x28 fp=0x2f7b7ec sp=0x2f7b7e4 pc=0x513240 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f7b7ec sp=0x2f7b7ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/player/player.go:183 +0x218 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 62 gp=0x2f70908 m=nil [chan receive]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3f90, 0x2c902b0, 0xe, 0x7, 0x2) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x3056748 sp=0x3056734 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv(0x2c90280, 0x30567d0, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x3056784 sp=0x3056748 pc=0x20078 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv2(0x2c90280, 0x30567d0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x3056798 sp=0x3056784 pc=0x1fbbc Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).withAppPlayer.func1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:268 +0x68 fp=0x30567ec sp=0x3056798 pc=0x63e794 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x30567ec sp=0x30567ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by main.(*App).withAppPlayer in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:265 +0x464 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 63 gp=0x2f70a28 m=nil [chan receive]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e3f90, 0x2c90270, 0xe, 0x7, 0x2) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x3056f40 sp=0x3056f2c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv(0x2c90240, 0x3056fe0, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x3056f7c sp=0x3056f40 pc=0x20078 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.chanrecv2(0x2c90240, 0x3056fe0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x3056f90 sp=0x3056f7c pc=0x1fbbc Dec 08 21:15:05 volumio go-librespot[4763]: main.(*App).withAppPlayer.func2() Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:284 +0x6c fp=0x3056fec sp=0x3056f90 pc=0x63e330 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x3056fec sp=0x3056fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by main.(*App).withAppPlayer in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/main.go:281 +0x504 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 64 gp=0x2f70b48 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3dc8, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x30575e8 sp=0x30575d4 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3db8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x3057600 sp=0x30575e8 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3db8, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x3057614 sp=0x3057600 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e26798, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x3057628 sp=0x3057614 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Accept(0x2e26780) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x3057670 sp=0x3057628 pc=0x10eb84 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).accept(0x2e26780) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x30576d8 sp=0x3057670 pc=0x17e4c4 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPListener).accept(0x304daa0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x30576f0 sp=0x30576d8 pc=0x196900 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPListener).Accept(0x304daa0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x305770c sp=0x30576f0 pc=0x19596c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*onceCloseListener).Accept(0x2f66b00) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x34 fp=0x3057724 sp=0x305770c pc=0x362b54 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*Server).Serve(0x2cb1688, {0x886cb8, 0x304daa0}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x30577bc sp=0x3057724 pc=0x341210 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.Serve(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2794 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Dec 08 21:15:05 volumio go-librespot[4763]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x30577ec sp=0x30577bc pc=0x5a8184 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x30577ec sp=0x30577ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Dec 08 21:15:05 volumio go-librespot[4763]: /src/zeroconf/zeroconf.go:280 +0x160 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 71 gp=0x2e9c5a8 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f7bea8 sp=0x2f7be94 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2f7bfa4, 0x2f7bf6c, 0x0, 0x0, 0x5, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2f7bf48 sp=0x2f7bea8 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x2ea8148) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x2f7bfe4 sp=0x2f7bf48 pc=0x474738 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.newConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x2f7bfec sp=0x2f7bfe4 pc=0x47432c Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f7bfec sp=0x2f7bfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by nhooyr.io/websocket.newConn in goroutine 61 Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 73 gp=0x2e9c6c8 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c446b8 sp=0x2c446a4 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2c447d4, 0x2c4477c, 0x0, 0x0, 0x2, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2c44758 sp=0x2c446b8 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x2f22008) Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:355 +0x8c fp=0x2c447e4 sp=0x2c44758 pc=0x48cb50 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:264 +0x28 fp=0x2c447ec sp=0x2c447e4 pc=0x48c248 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c447ec sp=0x2c447ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 61 Dec 08 21:15:05 volumio go-librespot[4763]: /src/ap/ap.go:264 +0x15c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 74 gp=0x2e9c7e8 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3a08, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x30d5940 sp=0x30d592c pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c39f8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x30d5958 sp=0x30d5940 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c39f8, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x30d596c sp=0x30d5958 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2ea5008, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x30d5980 sp=0x30d596c pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2ea4ff0, {0x3000000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x30d59c8 sp=0x30d5980 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2ea4ff0, {0x3000000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x30d59f4 sp=0x30d59c8 pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2d8dab8, {0x3000000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x30d5a20 sp=0x30d59f4 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2d8dab8, {0x3000000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x30d5a40 sp=0x30d5a20 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*atLeastReader).Read(0x2f1f360, {0x3000000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x30d5a6c sp=0x30d5a40 pc=0x27c680 Dec 08 21:15:05 volumio go-librespot[4763]: bytes.(*Buffer).ReadFrom(0x2d98ccc, {0x883674, 0x2f1f360}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x30d5aa8 sp=0x30d5a6c pc=0x139bd0 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readFromUntil(0x2d98b48, {0x882848, 0x2d8dab8}, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x30d5ad0 sp=0x30d5aa8 pc=0x27c8dc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecordOrCCS(0x2d98b48, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x30d5c34 sp=0x30d5ad0 pc=0x279fdc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecord(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).Read(0x2d98b48, {0x2eaf000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x30d5c64 sp=0x30d5c34 pc=0x27fe4c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*readWriteCloserBody).Read(0x2e6ea20, {0x2eaf000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/transport.go:2429 +0xec fp=0x30d5c84 sp=0x30d5c64 pc=0x357b00 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).fill(0x2c130b0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x30d5ca8 sp=0x30d5c84 pc=0x2bddb4 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).ReadByte(0x2c130b0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x30d5cb4 sp=0x30d5ca8 pc=0x2be638 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.readFrameHeader(0x2c130b0, {0x2ea8178, 0x8, 0x8}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x30d5cf4 sp=0x30d5cb4 pc=0x47788c Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x2ea8148, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x30d5db4 sp=0x30d5cf4 pc=0x47a4f0 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readLoop(0x2ea8148, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x30d5e78 sp=0x30d5db4 pc=0x479fd8 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).reader(0x2ea8148, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x30d5f04 sp=0x30d5e78 pc=0x47b1ec Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Reader(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Read(0x2ea8148, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x30d5f2c sp=0x30d5f04 pc=0x4798bc Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x2f22168) Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:188 +0x58 fp=0x30d5fe4 sp=0x30d5f2c pc=0x531d64 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:125 +0x28 fp=0x30d5fec sp=0x30d5fe4 pc=0x53383c Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x30d5fec sp=0x30d5fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 61 Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:125 +0x98 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 75 gp=0x2e9c908 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f77e98 sp=0x2f77e84 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2f77fd4, 0x2f77f60, 0x0, 0x0, 0x2, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2f77f38 sp=0x2f77e98 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x2f22168) Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:138 +0x8c fp=0x2f77fe4 sp=0x2f77f38 pc=0x5318dc Dec 08 21:15:05 volumio go-librespot[4763]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:129 +0x28 fp=0x2f77fec sp=0x2f77fe4 pc=0x5337e8 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f77fec sp=0x2f77fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 61 Dec 08 21:15:05 volumio go-librespot[4763]: /src/dealer/dealer.go:129 +0x15c Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 46 gp=0x2dd4a28 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3968, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2c55ad4 sp=0x2c55ac0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3958, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2c55aec sp=0x2c55ad4 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3958, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2c55b00 sp=0x2c55aec pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e34298, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2c55b14 sp=0x2c55b00 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2e34280, {0x30d9000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2c55b5c sp=0x2c55b14 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2e34280, {0x30d9000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2c55b88 sp=0x2c55b5c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x30e20d0, {0x30d9000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2c55bb4 sp=0x2c55b88 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x30e20d0, {0x30d9000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2c55bd4 sp=0x2c55bb4 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*atLeastReader).Read(0x2e6e020, {0x30d9000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x2c55c00 sp=0x2c55bd4 pc=0x27c680 Dec 08 21:15:05 volumio go-librespot[4763]: bytes.(*Buffer).ReadFrom(0x2e0a60c, {0x883674, 0x2e6e020}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x2c55c3c sp=0x2c55c00 pc=0x139bd0 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readFromUntil(0x2e0a488, {0x882848, 0x30e20d0}, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x2c55c64 sp=0x2c55c3c pc=0x27c8dc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecordOrCCS(0x2e0a488, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x2c55dc8 sp=0x2c55c64 pc=0x279fdc Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).readRecord(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 08 21:15:05 volumio go-librespot[4763]: crypto/tls.(*Conn).Read(0x2e0a488, {0x306a000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x2c55df8 sp=0x2c55dc8 pc=0x27fe4c Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).Read(0x3005500, {0x2cc6924, 0x9, 0x9}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x2c55e1c sp=0x2c55df8 pc=0x2be440 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadAtLeast({0x882a3c, 0x3005500}, {0x2cc6924, 0x9, 0x9}, 0x9) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2c55e48 sp=0x2c55e1c pc=0x1042c0 Dec 08 21:15:05 volumio go-librespot[4763]: io.ReadFull(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/io.go:354 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.http2readFrameHeader({0x2cc6924, 0x9, 0x9}, {0x882a3c, 0x3005500}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x2c55e70 sp=0x2c55e48 pc=0x2f733c Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Framer).ReadFrame(0x2cc6900) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x2c55eec sp=0x2c55e70 pc=0x2f7ad4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2clientConnReadLoop).run(0x2c55fdc) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x2c55fa4 sp=0x2c55eec pc=0x31c2f0 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2ClientConn).readLoop(0x2f8a108) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x2c55fe4 sp=0x2c55fa4 pc=0x31b7e4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x2c55fec sp=0x2c55fe4 pc=0x314830 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2c55fec sp=0x2c55fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*http2Transport).newClientConn in goroutine 45 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 76 gp=0x314e7e8 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c38c8, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dcb87c sp=0x2dcb868 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c38b8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dcb894 sp=0x2dcb87c pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c38b8, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2dcb8a8 sp=0x2dcb894 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x316f5a8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2dcb8bc sp=0x2dcb8a8 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x316f590, {0x2e82000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2dcb904 sp=0x2dcb8bc pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x316f590, {0x2e82000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2dcb930 sp=0x2dcb904 pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2c300c0, {0x2e82000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2dcb95c sp=0x2dcb930 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2c300c0, {0x2e82000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2dcb97c sp=0x2dcb95c pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: io.(*multiReader).Read(0x2e6e150, {0x2e82000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2dcb9a8 sp=0x2dcb97c pc=0x105528 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).fill(0x316cdb0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x2dcb9cc sp=0x2dcb9a8 pc=0x2bddb4 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).ReadByte(0x316cdb0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x2dcb9d8 sp=0x2dcb9cc pc=0x2be638 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.readFrameHeader(0x316cdb0, {0x2f182b8, 0x8, 0x8}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x2dcba18 sp=0x2dcb9d8 pc=0x47788c Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x2f18288, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x2dcbad8 sp=0x2dcba18 pc=0x47a4f0 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readLoop(0x2f18288, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x2dcbb9c sp=0x2dcbad8 pc=0x479fd8 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).reader(0x2f18288, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x2dcbc28 sp=0x2dcbb9c pc=0x47b1ec Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Reader(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Read(0x2f18288, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x2dcbc50 sp=0x2dcbc28 pc=0x4798bc Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x2dcbccc sp=0x2dcbc50 pc=0x633988 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c30190, {0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dcbcdc sp=0x2dcbccc pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*ServeMux).ServeHTTP(0x2c74000, {0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x2dcbd18 sp=0x2dcbcdc pc=0x33f654 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x2dcbd40 sp=0x2dcbd18 pc=0x633388 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c0e190, {0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dcbd50 sp=0x2dcbd40 pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.serverHandler.ServeHTTP({0x2c780a8}, {0x886dec, 0x2c78b48}, 0x2c78aa8) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x2dcbd6c sp=0x2dcbd50 pc=0x340de4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*conn).serve(0x3174420, {0x887510, 0x2c26198}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x2dcbfdc sp=0x2dcbd6c pc=0x33c034 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*Server).Serve.gowrap3() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x2dcbfec sp=0x2dcbfdc pc=0x341688 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2dcbfec sp=0x2dcbfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*Server).Serve in goroutine 23 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x468 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 78 gp=0x314e908 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f786a8 sp=0x2f78694 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2f787a4, 0x2f7876c, 0x0, 0x0, 0x5, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2f78748 sp=0x2f786a8 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x2f18288) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x2f787e4 sp=0x2f78748 pc=0x474738 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.newConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x2f787ec sp=0x2f787e4 pc=0x47432c Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f787ec sp=0x2f787ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by nhooyr.io/websocket.newConn in goroutine 76 Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 81 gp=0x314ea28 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3828, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2dcc87c sp=0x2dcc868 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3818, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2dcc894 sp=0x2dcc87c pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3818, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2dcc8a8 sp=0x2dcc894 pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x316f828, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2dcc8bc sp=0x2dcc8a8 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x316f810, {0x2c17000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2dcc904 sp=0x2dcc8bc pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x316f810, {0x2c17000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2dcc930 sp=0x2dcc904 pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x2c30d60, {0x2c17000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2dcc95c sp=0x2dcc930 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x2c30d60, {0x2c17000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2dcc97c sp=0x2dcc95c pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: io.(*multiReader).Read(0x2c0e050, {0x2c17000, 0x1000, 0x1000}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2dcc9a8 sp=0x2dcc97c pc=0x105528 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).fill(0x316d0e0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x2dcc9cc sp=0x2dcc9a8 pc=0x2bddb4 Dec 08 21:15:05 volumio go-librespot[4763]: bufio.(*Reader).ReadByte(0x316d0e0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x2dcc9d8 sp=0x2dcc9cc pc=0x2be638 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.readFrameHeader(0x316d0e0, {0x315c8f8, 0x8, 0x8}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x2dcca18 sp=0x2dcc9d8 pc=0x47788c Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x315c8c8, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x2dccad8 sp=0x2dcca18 pc=0x47a4f0 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).readLoop(0x315c8c8, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x2dccb9c sp=0x2dccad8 pc=0x479fd8 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).reader(0x315c8c8, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x2dccc28 sp=0x2dccb9c pc=0x47b1ec Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Reader(...) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).Read(0x315c8c8, {0x8874d0, 0xd0ad00}) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x2dccc50 sp=0x2dccc28 pc=0x4798bc Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x2dccccc sp=0x2dccc50 pc=0x633988 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c30190, {0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dcccdc sp=0x2dccccc pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*ServeMux).ServeHTTP(0x2c74000, {0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x2dccd18 sp=0x2dcccdc pc=0x33f654 Dec 08 21:15:05 volumio go-librespot[4763]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x2dccd40 sp=0x2dccd18 pc=0x633388 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.HandlerFunc.ServeHTTP(0x2c0e190, {0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x2dccd50 sp=0x2dccd40 pc=0x33d7f4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.serverHandler.ServeHTTP({0x2c780a8}, {0x886dec, 0x2c78dc8}, 0x2c78d28) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x2dccd6c sp=0x2dccd50 pc=0x340de4 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*conn).serve(0x3174540, {0x887510, 0x2c26198}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x2dccfdc sp=0x2dccd6c pc=0x33c034 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*Server).Serve.gowrap3() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x2dccfec sp=0x2dccfdc pc=0x341688 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2dccfec sp=0x2dccfec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*Server).Serve in goroutine 23 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:3285 +0x468 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 85 gp=0x314eb48 m=nil [select]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f78ea8 sp=0x2f78e94 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.selectgo(0x2f78fa4, 0x2f78f6c, 0x0, 0x0, 0x5, 0x1) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x2f78f48 sp=0x2f78ea8 pc=0x70e78 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x315c8c8) Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x2f78fe4 sp=0x2f78f48 pc=0x474738 Dec 08 21:15:05 volumio go-librespot[4763]: nhooyr.io/websocket.newConn.gowrap1() Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x2f78fec sp=0x2f78fe4 pc=0x47432c Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f78fec sp=0x2f78fec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by nhooyr.io/websocket.newConn in goroutine 81 Dec 08 21:15:05 volumio go-librespot[4763]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Dec 08 21:15:05 volumio go-librespot[4763]: goroutine 115 gp=0x314ec68 m=nil [IO wait]: Dec 08 21:15:05 volumio go-librespot[4763]: runtime.gopark(0x7e40f0, 0xb57c3788, 0x2, 0x2, 0x5) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x2f796b4 sp=0x2f796a0 pc=0x5d0c0 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.netpollblock(0xb57c3778, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x2f796cc sp=0x2f796b4 pc=0x548cc Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.runtime_pollWait(0xb57c3778, 0x72) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x2f796e0 sp=0x2f796cc pc=0x8f4a8 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).wait(0x2e342e8, 0x72, 0x0) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2f796f4 sp=0x2f796e0 pc=0x10a318 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*pollDesc).waitRead(...) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 08 21:15:05 volumio go-librespot[4763]: internal/poll.(*FD).Read(0x2e342d0, {0x2ee818d, 0x1, 0x1}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x2f7973c sp=0x2f796f4 pc=0x10b504 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*netFD).Read(0x2e342d0, {0x2ee818d, 0x1, 0x1}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x2f79768 sp=0x2f7973c pc=0x17c5d0 Dec 08 21:15:05 volumio go-librespot[4763]: net.(*conn).Read(0x30b8090, {0x2ee818d, 0x1, 0x1}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x2f79794 sp=0x2f79768 pc=0x18caec Dec 08 21:15:05 volumio go-librespot[4763]: net.(*TCPConn).Read(0x30b8090, {0x2ee818d, 0x1, 0x1}) Dec 08 21:15:05 volumio go-librespot[4763]: :1 +0x44 fp=0x2f797b4 sp=0x2f79794 pc=0x19fd40 Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*connReader).backgroundRead(0x2ee8180) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:681 +0x40 fp=0x2f797e4 sp=0x2f797b4 pc=0x335cfc Dec 08 21:15:05 volumio go-librespot[4763]: net/http.(*connReader).startBackgroundRead.gowrap2() Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:677 +0x28 fp=0x2f797ec sp=0x2f797e4 pc=0x335c34 Dec 08 21:15:05 volumio go-librespot[4763]: runtime.goexit({}) Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x2f797ec sp=0x2f797ec pc=0x93d6c Dec 08 21:15:05 volumio go-librespot[4763]: created by net/http.(*connReader).startBackgroundRead in goroutine 101 Dec 08 21:15:05 volumio go-librespot[4763]: /usr/local/go/src/net/http/server.go:677 +0x160 Dec 08 21:15:05 volumio go-librespot[4761]: Aborted Dec 08 21:15:06 volumio volumio[1270]: info: Getting Spotify volume Dec 08 21:15:06 volumio volumio[1270]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 21:15:06 volumio volumio[1270]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 08 21:15:06 volumio volumio[1270]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 08 21:15:06 volumio volumio[1270]: errno: -111, Dec 08 21:15:06 volumio volumio[1270]: code: 'ECONNREFUSED', Dec 08 21:15:06 volumio volumio[1270]: syscall: 'connect', Dec 08 21:15:06 volumio volumio[1270]: address: '127.0.0.1', Dec 08 21:15:06 volumio volumio[1270]: port: 9879, Dec 08 21:15:06 volumio volumio[1270]: response: undefined Dec 08 21:15:06 volumio volumio[1270]: } Dec 08 21:15:06 volumio volumio[1270]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 21:15:06 volumio sudo[4816]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-08 21:14' Dec 08 21:15:06 volumio sudo[4816]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"