-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-06-22 09:12:19 CEST. -- Jun 22 09:12:16 volumio systemd-timedated[1246]: Changed local time to Sun Jun 22 09:12:16 2025 Jun 22 09:12:16 volumio sudo[1244]: pam_unix(sudo:session): session closed for user root Jun 22 09:12:16 volumio volumio-time-update[565]: volumio-time-update-util: System time updated successfully. Jun 22 09:12:16 volumio volumio[974]: info: Discovery: A device disappeared from network Jun 22 09:12:16 volumio volumio[974]: info: Discovery: Device volumio disappeared from network Jun 22 09:12:16 volumio systemd[1]: Starting Daily apt download activities... Jun 22 09:12:16 volumio systemd[1]: Started Volumio Time Update Utility. Jun 22 09:12:16 volumio systemd[1]: Reached target Multi-User System. Jun 22 09:12:16 volumio systemd[1]: Reached target Graphical Interface. Jun 22 09:12:16 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 22 09:12:16 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 22 09:12:16 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 22 09:12:16 volumio go-librespot[1201]: time="2025-06-22T09:12:16+02:00" level=debug msg="resolved context of track" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:16 volumio go-librespot[1201]: time="2025-06-22T09:12:16+02:00" level=trace msg="fetched new page 0 with 50 items (list: 50)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:16 volumio volumio[974]: info: Discovery: adding 6fa7ac39-c2ab-4b24-b75b-b20f786c5afa Jun 22 09:12:16 volumio volumio[974]: info: Discovery: Found device Volumio Jun 22 09:12:16 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Jun 22 09:12:16 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 22 09:12:16 volumio volumio[974]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 22 09:12:16 volumio go-librespot[1201]: time="2025-06-22T09:12:16+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:16 volumio go-librespot[1201]: time="2025-06-22T09:12:16+02:00" level=trace msg="fetched new page 1 with 50 items (list: 100)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio volumio[974]: info: Initializing connection to go-librespot Websocket Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="new websocket client" Jun 22 09:12:17 volumio volumio[974]: info: Connection to go-librespot Websocket established Jun 22 09:12:17 volumio sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 09:12:17 volumio sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 09:12:17 volumio sudo[1296]: pam_unix(sudo:session): session closed for user root Jun 22 09:12:17 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 09:12:17 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 09:12:17 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root Jun 22 09:12:17 volumio sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 22 09:12:17 volumio sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=trace msg="fetched new page 2 with 50 items (list: 150)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 22 09:12:17 volumio sudo[1302]: pam_unix(sudo:session): session closed for user root Jun 22 09:12:17 volumio volumio[974]: info: Upmpdcli Daemon Started Jun 22 09:12:17 volumio volumio[1304]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=trace msg="fetched new page from (has next: true)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=trace msg="fetched new page 3 with 50 items (list: 200)" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=warning msg="failed seeking to track in context spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" error="failed fetching tracks for seek: failed moving to next index 200 (page 4): failed fetching next page: invalid status code from page at radio-apollo/v5/tracks/spotify:station:playlist:37i9dQZF1E36xZrwiLR41X?salt=343835&autoplay=false&count=50&isVideo=false&prev_tracks=6HYHIPcS5U0PLhD6u43MRX,7MZHqgTVTnN6xZGYAcEEAf,2i6H4Pv8FAGamAIdftleDu,6MUmOqr4xP2fwgCjR2BTLn,4n5M8BJ7gekZI4lDbAQjKU,3tpbTvR9pNB6A3fOzGyMZd,62sHewU6Gfr2g3f7vRFZit,7KncmixRfCnvzSsKZnlHt8,21T0qnyX1ybeEvb1ddRnI3,38wjP4MzvQRkJRgXz5F0LO,0k3oBXJD5RJGgHDi9SwuES,6eCBdezKhVmQevJbaA8G5S,1YYK8zYkBKxVaANQ7CkgYu,7g93COdRFvOxwpxPlvrqLM,0E9acaaXe7DUKgmEbnEaC4,37XsaGX7crh4YJKv6k946u,3xKsGYkJKy0bbQuUHRYrei,3EwTIu5qka2l5ZekB0b6QC,5T1TrM1JTB0igswZSOKKi3,0Xuh7O6BMfWnwA3SW81jV1,0aTsSP2JiY53i0uZM24Zwp,4xFBcEj1oXRr1dRPoP7OBf,2twuKLhUWkc1oWUfBxMO2t,7pOrN8TYTjTzDZYQMShjXl,2DiIOqLv8gFf1AShjS4nEi,50PsIMoFsYh2clFHipEi8c,09bThZXhtWY4oPvAThoLvj,3pNxB32GZ03zJQ3fmUqsj5,4JF3UTZjcVa20zOaxSmnzj,61YcJKRn2y1si5jGc7LUIN,3QJtQCtKVX5rLNYEsy4CWA,7oTvcGyX0llNf9X3pFy8sd,2FhyTzw49NtYw29JEFvdu2,5yOnx6qeKUtMie3WlfUkAt,1rcu88dzWE5GyqtpuWvd0C,1x1zGuT83cK1gDYZzCSVrk,6mgZxHEtNHG5jGh2zkvSvs,4hui0bX1Bv89yg1BTsz4NU,073QmHGlZVfCHLDbpbboE3,6MNCyAY8Nzw0nLepfvbs2R,5IXA8J6Xugs507nAzwSa5F,4lGB47Vt4RC2io2cpS1XaS,2PIcAQiSOayFwJrfWc72Qc,6CltzquypraYIlWFp48m1O,14Z6bWa5MGCXoRm8JCBxCs,3PBnPJihXFgMghQqhF7RnY,7pOmPDPMqRQcom7viDKrBY,0BPKqNWOKQam19tKWoZQwu,1QXFkl9yG16VS7IOqcidiq,2lu7sjHd7gRf2xfv9PM7Fe&minimal=true?salt=130152&autoplay=false&count=50&isVideo=false&prev_tracks=6HYHIPcS5U0PLhD6u43MRX,7MZHqgTVTnN6xZGYAcEEAf,67zugn57NW0eFNM3DL4IxD,4n5M8BJ7gekZI4lDbAQjKU,3sjgaVtZIOEwR21pfM42Ly,6YYU9JbeWnW4L5NY7hlLlw,62sHewU6Gfr2g3f7vRFZit,21T0qnyX1ybeEvb1ddRnI3,7KncmixRfCnvzSsKZnlHt8,38wjP4MzvQRkJRgXz5F0LO,0k3oBXJD5RJGgHDi9SwuES,6eCBdezKhVmQevJbaA8G5S,2twuKLhUWkc1oWUfBxMO2t,0E9acaaXe7DUKgmEbnEaC4,0Xuh7O6BMfWnwA3SW81jV1,0aTsSP2JiY53i0uZM24Zwp,09bThZXhtWY4oPvAThoLvj,2i6H4Pv8FAGamAIdftleDu,5T1TrM1JTB0igswZSOKKi3,4xFBcEj1oXRr1dRPoP7OBf,50PsIMoFsYh2clFHipEi8c,6MUmOqr4xP2fwgCjR2BTLn,1YYK8zYkBKxVaANQ7CkgYu,2DiIOqLv8gFf1AShjS4nEi,7pOrN8TYTjTzDZYQMShjXl,3pNxB32GZ03zJQ3fmUqsj5,7oTvcGyX0llNf9X3pFy8sd,4JF3UTZjcVa20zOaxSmnzj,61YcJKRn2y1si5jGc7LUIN,4kawArrYyru9uT0phHxWKt,4D2rEIyYw0meeh8AOXqfxK,3PBnPJihXFgMghQqhF7RnY,7g93COdRFvOxwpxPlvrqLM,14Z6bWa5MGCXoRm8JCBxCs,073QmHGlZVfCHLDbpbboE3,4lGB47Vt4RC2io2cpS1XaS,2XW09IcRiljgMFYo5znLVU,5yOnx6qeKUtMie3WlfUkAt,0qWgm1JTDWdfJX9Lsj8mdR,3bT26KkmTadS215IWgDR7O,1x1zGuT83cK1gDYZzCSVrk,2FhyTzw49NtYw29JEFvdu2,3f7OyfSoDbQC0LRDQiytPp,6MNCyAY8Nzw0nLepfvbs2R,4hui0bX1Bv89yg1BTsz4NU,1kDc700KN1jUerY6t09FNm,7pOmPDPMqRQcom7viDKrBY,01WnKRbZWhZaiF5YfOVJoz,0Tyi56S51KsufCIcqRHWCN,3gLwVUwVAitcf7Lj1DxN0K?salt=543856&autoplay=false&count=50&isVideo=false&prev_tracks=3lTj6VhUedrKhpCsw5Rnbb,6HYHIPcS5U0PLhD6u43MRX,7MZHqgTVTnN6xZGYAcEEAf,2DiIOqLv8gFf1AShjS4nEi,3tzU46wNOVaFiYRNtNYY66,2RSTIsdhq5vqqr2GcTFdGM,2twuKLhUWkc1oWUfBxMO2t,05I2kbWf5P3xdCVQve7apz,7KncmixRfCnvzSsKZnlHt8,01WnKRbZWhZaiF5YfOVJoz,38wjP4MzvQRkJRgXz5F0LO,21T0qnyX1ybeEvb1ddRnI3,0aTsSP2JiY53i0uZM24Zwp,6eCBdezKhVmQevJbaA8G5S,7g93COdRFvOxwpxPlvrqLM,62sHewU6Gfr2g3f7vRFZit,61YcJKRn2y1si5jGc7LUIN,5fZ9ls5QMb0SpqgGsjq47M,073QmHGlZVfCHLDbpbboE3,3pNxB32GZ03zJQ3fmUqsj5,50PsIMoFsYh2clFHipEi8c,1YYK8zYkBKxVaANQ7CkgYu,5T1TrM1JTB0igswZSOKKi3,37XsaGX7crh4YJKv6k946u,0AS03vnvXv9m0ZFxtuvOBW,4xFBcEj1oXRr1dRPoP7OBf,0Xuh7O6BMfWnwA3SW81jV1,7pOrN8TYTjTzDZYQMShjXl,4n5M8BJ7gekZI4lDbAQjKU,6MUmOqr4xP2fwgCjR2BTLn,3f7OyfSoDbQC0LRDQiytPp,0E9acaaXe7DUKgmEbnEaC4,4hui0bX1Bv89yg1BTsz4NU,1tenXdRDmbXA1spfbDSxmc,4lGB47Vt4RC2io2cpS1XaS,1x1zGuT83cK1gDYZzCSVrk,0BPKqNWOKQam19tKWoZQwu,4D2rEIyYw0meeh8AOXqfxK,7oTvcGyX0llNf9X3pFy8sd,0lH1I1XcwiIcJ6wqiTK7VK,2XW09IcRiljgMFYo5znLVU,5yOnx6qeKUtMie3WlfUkAt,0Tyi56S51KsufCIcqRHWCN,09bThZXhtWY4oPvAThoLvj,6R1y3I91AIktu7qoKIugtH,5Xinke5CL0UrKNenCaOzHg,1rcu88dzWE5GyqtpuWvd0C,3PBnPJihXFgMghQqhF7RnY,0JD0obuAFNsP2J8pSfd9Pf,6kM8MKfrsjxKfYPjIJno3c?salt=54020&autoplay=false&count=50&isVideo=false&prev_tracks=1i1yttW6E8E7iNwhrCvz8U,6HYHIPcS5U0PLhD6u43MRX,7MZHqgTVTnN6xZGYAcEEAf,2i6H4Pv8FAGamAIdftleDu,37XsaGX7crh4YJKv6k946u,2RSTIsdhq5vqqr2GcTFdGM,3tzU46wNOVaFiYRNtNYY66,2twuKLhUWkc1oWUfBxMO2t,01WnKRbZWhZaiF5YfOVJoz,38wjP4MzvQRkJRgXz5F0LO,3kROc4cT1QMKyQdPd0Gbvm,4shJVGH4xRWChBSkHHamxv,21T0qnyX1ybeEvb1ddRnI3,0E9acaaXe7DUKgmEbnEaC4,62sHewU6Gfr2g3f7vRFZit,6eCBdezKhVmQevJbaA8G5S,50PsIMoFsYh2clFHipEi8c,61YcJKRn2y1si5jGc7LUIN,11wHmDneCglIJZRMOMUhUw,4xFBcEj1oXRr1dRPoP7OBf,1YYK8zYkBKxVaANQ7CkgYu,1kDc700KN1jUerY6t09FNm,7KncmixRfCnvzSsKZnlHt8,6MUmOqr4xP2fwgCjR2BTLn,4kawArrYyru9uT0phHxWKt,3pNxB32GZ03zJQ3fmUqsj5,09bThZXhtWY4oPvAThoLvj,14Z6bWa5MGCXoRm8JCBxCs,4hui0bX1Bv89yg1BTsz4NU,073QmHGlZVfCHLDbpbboE3,1x1zGuT83cK1gDYZzCSVrk,6MNCyAY8Nzw0nLepfvbs2R,4D2rEIyYw0meeh8AOXqfxK,2VcS3oKcOPkubN9LVzZ96l,7g93COdRFvOxwpxPlvrqLM,3f7OyfSoDbQC0LRDQiytPp,1tenXdRDmbXA1spfbDSxmc,3PBnPJihXFgMghQqhF7RnY,5OVHnu9SgsdAravy4UyGq4,48imQdLemJT1EWoHP7cd4d,0Xuh7O6BMfWnwA3SW81jV1,0BPKqNWOKQam19tKWoZQwu,0mjOx4zUlL5t4rF1xnrfvi,3gLwVUwVAitcf7Lj1DxN0K,1rcu88dzWE5GyqtpuWvd0C,2FhyTzw49NtYw29JEFvdu2,7oTvcGyX0llNf9X3pFy8sd,0AS03vnvXv9m0ZFxtuvOBW,7GvkOFkNsM6Exnkyqeajqm,1jyupVWaFT6GKhQiD1rPjh: 414" uri="spotify:station:playlist:37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="loading track (paused: false, position: 265007ms)" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=trace msg="emitting websocket event: will_play" Jun 22 09:12:17 volumio volumio[974]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:6HYHIPcS5U0PLhD6u43MRX","play_origin":""}} Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="selected format OGG_VORBIS_320 (c12b9978f031655e2320a6747c13c480c0e616a6)" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:17 volumio go-librespot[1201]: time="2025-06-22T09:12:17+02:00" level=debug msg="requested aes key for file c12b9978f031655e2320a6747c13c480c0e616a6, gid: 6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio systemd[1]: apt-daily.service: Succeeded. Jun 22 09:12:18 volumio systemd[1]: Started Daily apt download activities. Jun 22 09:12:18 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1324" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="fetched first chunk of 15, total size is 7845328 bytes" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1106" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 137" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 137" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="fetched chunk 14/14, size: 505296" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=trace msg="seek to 190574ms (diff: 442ms, samples: 8404313, bytes: 7835744)" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="created new output device" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 124988 us, period size = 5512 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 4 frames" Jun 22 09:12:18 volumio go-librespot[1201]: time="2025-06-22T09:12:18+02:00" level=info msg="loaded track \"The Rope\" (paused: false, position: 265007ms, duration: 190574ms, prefetched: false)" uri="spotify:track:6HYHIPcS5U0PLhD6u43MRX" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=trace msg="emitting websocket event: metadata" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=trace msg="emitting websocket event: active" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="sending successful reply for dealer request" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="prefetching next track" uri="spotify:track:7MZHqgTVTnN6xZGYAcEEAf" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="skipping dealer message" uri="hm://playlist/v2/playlist/37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="skipping dealer message" uri="hm://playlist/v2/playlist/37i9dQZF1E36xZrwiLR41X" Jun 22 09:12:19 volumio volumio[974]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:6HYHIPcS5U0PLhD6u43MRX","name":"The Rope","artist_names":["Wunderhorse"],"album_name":"The Rope","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02a088e5415c23f0568625d049","position":265007,"duration":190574,"release_date":"year:2025 month:6 day:2","track_number":1,"disc_number":1}} Jun 22 09:12:19 volumio volumio[974]: SPOTIFY: received: {"type":"active","data":null} Jun 22 09:12:19 volumio volumio[974]: info: Aligning Spotify Volume to Volumio Volume Jun 22 09:12:19 volumio volumio[974]: info: CoreCommandRouter::volumioGetState Jun 22 09:12:19 volumio volumio[974]: info: CorePlayQueue::getTrack 0 Jun 22 09:12:19 volumio volumio[974]: info: Setting Spotify Volume from Volumio: 52 Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="selected format OGG_VORBIS_320 (4605d1364d9cccad2863f31f901e04e74b7ab8e5)" uri="spotify:track:7MZHqgTVTnN6xZGYAcEEAf" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="requested aes key for file 4605d1364d9cccad2863f31f901e04e74b7ab8e5, gid: 7MZHqgTVTnN6xZGYAcEEAf" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=trace msg="emitting websocket event: playing" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=info msg="playback was transferred to Pixel 8 Pro" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=trace msg="closed output device because of stop command" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jun 22 09:12:19 volumio volumio[974]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:6HYHIPcS5U0PLhD6u43MRX","play_origin":""}} Jun 22 09:12:19 volumio volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 09:12:19 volumio volumio[974]: TypeError: Cannot read property 'service' of undefined Jun 22 09:12:19 volumio volumio[974]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:340:50) Jun 22 09:12:19 volumio volumio[974]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:266:18) Jun 22 09:12:19 volumio volumio[974]: at WebSocket.message (/data/plugins/music_service/spop/index.js:193:14) Jun 22 09:12:19 volumio volumio[974]: at WebSocket.emit (events.js:315:20) Jun 22 09:12:19 volumio volumio[974]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) Jun 22 09:12:19 volumio volumio[974]: at Receiver.emit (events.js:315:20) Jun 22 09:12:19 volumio volumio[974]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Jun 22 09:12:19 volumio volumio[974]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Jun 22 09:12:19 volumio volumio[974]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Jun 22 09:12:19 volumio volumio[974]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Jun 22 09:12:19 volumio volumio[974]: at writeOrBuffer (internal/streams/writable.js:358:12) Jun 22 09:12:19 volumio volumio[974]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Jun 22 09:12:19 volumio volumio[974]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) Jun 22 09:12:19 volumio volumio[974]: at Socket.emit (events.js:315:20) Jun 22 09:12:19 volumio volumio[974]: at addChunk (internal/streams/readable.js:309:12) Jun 22 09:12:19 volumio volumio[974]: at readableAddChunk (internal/streams/readable.js:284:9) Jun 22 09:12:19 volumio volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=debug msg="put connect state inactive" Jun 22 09:12:19 volumio go-librespot[1201]: time="2025-06-22T09:12:19+02:00" level=trace msg="emitting websocket event: inactive" Jun 22 09:12:19 volumio go-librespot[1201]: panic: runtime error: invalid memory address or nil pointer dereference Jun 22 09:12:19 volumio go-librespot[1201]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x14 pc=0x5ec094] Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 49 gp=0x1084ea8 m=5 mp=0x1080008 [running]: Jun 22 09:12:19 volumio go-librespot[1201]: panic({0x67bd18, 0xb7c2a0}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x121b824 sp=0x121b7d0 pc=0x58b00 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.panicmem(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/panic.go:261 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.sigpanic() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/signal_unix.go:881 +0x39c fp=0x121b854 sp=0x121b824 pc=0x74aec Jun 22 09:12:19 volumio go-librespot[1201]: main.(*AppPlayer).handlePlayerEvent(0x13000a0, {0x7d7634, 0xbf6000}, 0x121ba54) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/controls.go:108 +0x2d4 fp=0x121b8f4 sp=0x121b858 pc=0x5ec094 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*AppPlayer).Run(0x13000a0, {0x7d7634, 0xbf6000}, 0x1092200) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/player.go:593 +0x740 fp=0x121bfd8 sp=0x121b8f4 pc=0x5fb2f0 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*App).withAppPlayer.func3.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:352 +0x40 fp=0x121bfec sp=0x121bfd8 pc=0x5f3494 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x121bfec sp=0x121bfec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by main.(*App).withAppPlayer.func3 in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:352 +0x50c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 1 gp=0x1002128 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11cdd2c sp=0x11cdd18 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x11cde2c, 0x121ddf8, 0x0, 0x0, 0x2, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x11cddcc sp=0x11cdd2c pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x115f7a0, 0x11cdeb8) Jun 22 09:12:19 volumio go-librespot[1201]: /src/zeroconf/zeroconf.go:270 +0x228 fp=0x11cde70 sp=0x11cddcc pc=0x55dd34 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*App).withAppPlayer(0x1112840, {0x7d7634, 0xbf6000}, 0x11114f0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:316 +0x514 fp=0x11cdef8 sp=0x11cde70 pc=0x5f2dcc Jun 22 09:12:19 volumio go-librespot[1201]: main.(*App).Zeroconf(...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:168 Jun 22 09:12:19 volumio go-librespot[1201]: main.main() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:610 +0x918 fp=0x11cdfa8 sp=0x11cdef8 pc=0x5f5d54 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.main() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x11cdfec sp=0x11cdfa8 pc=0x5ca38 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11cdfec sp=0x11cdfec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 18 gp=0x1084248 m=nil [force gc (idle)]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736864, 0xbca928, 0x11, 0xa, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x10407d4 sp=0x10407c0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goparkunlock(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:408 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.forcegchelper() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x10407ec sp=0x10407d4 pc=0x5ce04 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10407ec sp=0x10407ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.init.5 in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:314 +0x1c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 19 gp=0x1084368 m=nil [GC sweep wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736864, 0xbcaee0, 0xc, 0x9, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1040fc4 sp=0x1040fb0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goparkunlock(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:408 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.bgsweep(0x1092000) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x1040fe4 sp=0x1040fc4 pc=0x45750 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcenable.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x1040fec sp=0x1040fe4 pc=0x35870 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1040fec sp=0x1040fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcenable in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 20 gp=0x1084488 m=nil [GC scavenge wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736864, 0xbcb508, 0xd, 0xa, 0x2) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x10417b4 sp=0x10417a0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goparkunlock(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:408 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.(*scavengerState).park(0xbcb508) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x10417c8 sp=0x10417b4 pc=0x42a70 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.bgscavenge(0x1092000) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x10417e4 sp=0x10417c8 pc=0x431a8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcenable.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x10417ec sp=0x10417e4 pc=0x3581c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10417ec sp=0x10417ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcenable in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 34 gp=0x1114008 m=nil [finalizer wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736710, 0xbf609c, 0x10, 0xa, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x111a78c sp=0x111a778 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.runfinq() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x111a7ec sp=0x111a78c pc=0x3465c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x111a7ec sp=0x111a7ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.createfing in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 37 gp=0x1115208 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025f18, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x111ad28 sp=0x111ad14 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025f08, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x111ad40 sp=0x111ad28 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025f08, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x111ad54 sp=0x111ad40 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1102ec8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x111ad68 sp=0x111ad54 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Accept(0x1102eb0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x111adb0 sp=0x111ad68 pc=0x10eb44 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).accept(0x1102eb0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x111ae18 sp=0x111adb0 pc=0x17e32c Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPListener).accept(0x111e4f8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x111ae30 sp=0x111ae18 pc=0x19642c Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPListener).Accept(0x111e4f8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x111ae4c sp=0x111ae30 pc=0x195498 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*onceCloseListener).Accept(0x107e440) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x34 fp=0x111ae64 sp=0x111ae4c pc=0x362680 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Server).Serve(0x107a148, {0x7d6e18, 0x111e4f8}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x111aefc sp=0x111ae64 pc=0x340d3c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.Serve(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2794 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*ConcreteApiServer).serve(0x115e360) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/api_server.go:610 +0x974 fp=0x111afe4 sp=0x111aefc pc=0x5e8bc0 Jun 22 09:12:19 volumio go-librespot[1201]: main.NewApiServer.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/api_server.go:289 +0x28 fp=0x111afec sp=0x111afe4 pc=0x5e7a90 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x111afec sp=0x111afec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by main.NewApiServer in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/api_server.go:289 +0x310 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 118 gp=0x1115328 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025838, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11cbafc sp=0x11cbae8 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025828, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x11cbb14 sp=0x11cbafc pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025828, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x11cbb28 sp=0x11cbb14 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x12a82e8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11cbb3c sp=0x11cbb28 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x12a82d0, {0x1424000, 0xa000, 0xa000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x11cbb84 sp=0x11cbb3c pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x12a82d0, {0x1424000, 0xa000, 0xa000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x11cbbb0 sp=0x11cbb84 pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1111980, {0x1424000, 0xa000, 0xa000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x11cbbdc sp=0x11cbbb0 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1111980, {0x1424000, 0xa000, 0xa000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x11cbbfc sp=0x11cbbdc pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x13ce140, {0x1424000, 0xa000, 0xa000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x11cbc28 sp=0x11cbbfc pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x1227c8c, {0x7d4554, 0x13ce140}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x11cbc64 sp=0x11cbc28 pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x1227b08, {0x7d373c, 0x1111980}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x11cbc8c sp=0x11cbc64 pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x1227b08, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x11cbdf0 sp=0x11cbc8c pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x1227b08, {0x120d000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x11cbe20 sp=0x11cbdf0 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).Read(0x10ea378, {0x120d000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1977 +0x16c fp=0x11cbe54 sp=0x11cbe20 pc=0x3550f8 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).fill(0x11b3290) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x11cbe78 sp=0x11cbe54 pc=0x2bd8e0 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Peek(0x11b3290, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:148 +0x68 fp=0x11cbe84 sp=0x11cbe78 pc=0x2bda64 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).readLoop(0x10ea378) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2141 +0x194 fp=0x11cbfe4 sp=0x11cbe84 pc=0x355c88 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Transport).dialConn.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1799 +0x28 fp=0x11cbfec sp=0x11cbfe4 pc=0x3545a8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11cbfec sp=0x11cbfec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*Transport).dialConn in goroutine 81 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1799 +0x13f4 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 69 gp=0x1115448 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025a18, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1055ad4 sp=0x1055ac0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025a08, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1055aec sp=0x1055ad4 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025a08, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1055b00 sp=0x1055aec pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x13e3148, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1055b14 sp=0x1055b00 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x13e3130, {0x1456000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1055b5c sp=0x1055b14 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x13e3130, {0x1456000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1055b88 sp=0x1055b5c pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1110058, {0x1456000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1055bb4 sp=0x1055b88 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1110058, {0x1456000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x1055bd4 sp=0x1055bb4 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x1378d80, {0x1456000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1055c00 sp=0x1055bd4 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x12263cc, {0x7d4554, 0x1378d80}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1055c3c sp=0x1055c00 pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x1226248, {0x7d373c, 0x1110058}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1055c64 sp=0x1055c3c pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x1226248, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1055dc8 sp=0x1055c64 pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x1226248, {0x13e8000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1055df8 sp=0x1055dc8 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Read(0x1001440, {0x11626a4, 0x9, 0x9}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1055e1c sp=0x1055df8 pc=0x2bdf6c Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAtLeast({0x7d3930, 0x1001440}, {0x11626a4, 0x9, 0x9}, 0x9) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1055e48 sp=0x1055e1c pc=0x104280 Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadFull(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:354 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.http2readFrameHeader({0x11626a4, 0x9, 0x9}, {0x7d3930, 0x1001440}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1055e70 sp=0x1055e48 pc=0x2f6e68 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Framer).ReadFrame(0x1162680) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1055eec sp=0x1055e70 pc=0x2f7600 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2clientConnReadLoop).run(0x1055fdc) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1055fa4 sp=0x1055eec pc=0x31be1c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2ClientConn).readLoop(0x10e2208) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1055fe4 sp=0x1055fa4 pc=0x31b310 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Transport).newClientConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1055fec sp=0x1055fe4 pc=0x31435c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1055fec sp=0x1055fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*http2Transport).newClientConn in goroutine 68 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 3 gp=0x1115568 m=nil [GC worker (idle)]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736720, 0x10ac168, 0x1a, 0xa, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1044790 sp=0x104477c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcBgMarkWorker() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x10447ec sp=0x1044790 pc=0x38498 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10447ec sp=0x10447ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcBgMarkStartWorkers in goroutine 2 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 50 gp=0x1500008 m=nil [GC worker (idle)]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736720, 0x1502000, 0x1a, 0xa, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1116790 sp=0x111677c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcBgMarkWorker() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x11167ec sp=0x1116790 pc=0x38498 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11167ec sp=0x11167ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcBgMarkStartWorkers in goroutine 2 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 51 gp=0x1500128 m=nil [GC worker (idle)]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736720, 0x1502018, 0x1a, 0xa, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1116f90 sp=0x1116f7c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcBgMarkWorker() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1116fec sp=0x1116f90 pc=0x38498 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1116fec sp=0x1116fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcBgMarkStartWorkers in goroutine 2 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 52 gp=0x1500248 m=nil [GC worker (idle)]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736720, 0x1502030, 0x1a, 0xa, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1117790 sp=0x111777c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gcBgMarkWorker() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x11177ec sp=0x1117790 pc=0x38498 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11177ec sp=0x11177ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by runtime.gcBgMarkStartWorkers in goroutine 2 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 22 gp=0x1002d88 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025e78, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11d0ad4 sp=0x11d0ac0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025e68, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x11d0aec sp=0x11d0ad4 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025e68, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x11d0b00 sp=0x11d0aec pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1103058, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11d0b14 sp=0x11d0b00 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x1103040, {0x1238000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x11d0b5c sp=0x11d0b14 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x1103040, {0x1238000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x11d0b88 sp=0x11d0b5c pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1030248, {0x1238000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x11d0bb4 sp=0x11d0b88 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1030248, {0x1238000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x11d0bd4 sp=0x11d0bb4 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x100ea50, {0x1238000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x11d0c00 sp=0x11d0bd4 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x122618c, {0x7d4554, 0x100ea50}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x11d0c3c sp=0x11d0c00 pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x1226008, {0x7d373c, 0x1030248}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x11d0c64 sp=0x11d0c3c pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x1226008, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x11d0dc8 sp=0x11d0c64 pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x1226008, {0x12f4000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x11d0df8 sp=0x11d0dc8 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Read(0x114ecf0, {0x1208024, 0x9, 0x9}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x11d0e1c sp=0x11d0df8 pc=0x2bdf6c Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAtLeast({0x7d3930, 0x114ecf0}, {0x1208024, 0x9, 0x9}, 0x9) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x11d0e48 sp=0x11d0e1c pc=0x104280 Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadFull(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:354 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.http2readFrameHeader({0x1208024, 0x9, 0x9}, {0x7d3930, 0x114ecf0}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x11d0e70 sp=0x11d0e48 pc=0x2f6e68 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Framer).ReadFrame(0x1208000) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x11d0eec sp=0x11d0e70 pc=0x2f7600 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2clientConnReadLoop).run(0x11d0fdc) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x11d0fa4 sp=0x11d0eec pc=0x31be1c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2ClientConn).readLoop(0x112d508) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x11d0fe4 sp=0x11d0fa4 pc=0x31b310 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Transport).newClientConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x11d0fec sp=0x11d0fe4 pc=0x31435c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11d0fec sp=0x11d0fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*http2Transport).newClientConn in goroutine 21 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 104 gp=0x1114908 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025978, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1474ad4 sp=0x1474ac0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025968, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1474aec sp=0x1474ad4 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025968, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1474b00 sp=0x1474aec pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x130f468, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1474b14 sp=0x1474b00 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x130f450, {0x1336000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1474b5c sp=0x1474b14 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x130f450, {0x1336000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1474b88 sp=0x1474b5c pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1031268, {0x1336000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1474bb4 sp=0x1474b88 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1031268, {0x1336000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x1474bd4 sp=0x1474bb4 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x133a380, {0x1336000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1474c00 sp=0x1474bd4 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x1319c8c, {0x7d4554, 0x133a380}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1474c3c sp=0x1474c00 pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x1319b08, {0x7d373c, 0x1031268}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1474c64 sp=0x1474c3c pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x1319b08, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1474dc8 sp=0x1474c64 pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x1319b08, {0x135a000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1474df8 sp=0x1474dc8 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Read(0x114ea20, {0x10b48a4, 0x9, 0x9}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1474e1c sp=0x1474df8 pc=0x2bdf6c Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAtLeast({0x7d3930, 0x114ea20}, {0x10b48a4, 0x9, 0x9}, 0x9) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1474e48 sp=0x1474e1c pc=0x104280 Jun 22 09:12:19 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadFull(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:354 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.http2readFrameHeader({0x10b48a4, 0x9, 0x9}, {0x7d3930, 0x114ea20}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1474e70 sp=0x1474e48 pc=0x2f6e68 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Framer).ReadFrame(0x10b4880) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1474eec sp=0x1474e70 pc=0x2f7600 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2clientConnReadLoop).run(0x1474fdc) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1474fa4 sp=0x1474eec pc=0x31be1c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2ClientConn).readLoop(0x112d708) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1474fe4 sp=0x1474fa4 pc=0x31b310 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Transport).newClientConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1474fec sp=0x1474fe4 pc=0x31435c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1474fec sp=0x1474fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*http2Transport).newClientConn in goroutine 103 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 6 gp=0x1114a28 m=nil [chan receive]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x7366f4, 0x110e130, 0xe, 0x7, 0x2) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1042f48 sp=0x1042f34 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.chanrecv(0x110e100, 0x1042fd0, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1042f84 sp=0x1042f48 pc=0x1ff80 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.chanrecv2(0x110e100, 0x1042fd0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1042f98 sp=0x1042f84 pc=0x1fac4 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*App).withAppPlayer.func1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:264 +0x68 fp=0x1042fec sp=0x1042f98 pc=0x5f3964 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1042fec sp=0x1042fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by main.(*App).withAppPlayer in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:261 +0x424 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 7 gp=0x1114b48 m=nil [runnable]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x7366f4, 0x110e0f0, 0xe, 0x7, 0x2) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1043738 sp=0x1043724 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.chanrecv(0x110e0c0, 0x10437e0, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1043774 sp=0x1043738 pc=0x1ff80 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.chanrecv2(0x110e0c0, 0x10437e0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1043788 sp=0x1043774 pc=0x1fac4 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*App).withAppPlayer.func2() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:280 +0x6c fp=0x10437ec sp=0x1043788 pc=0x5f352c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x10437ec sp=0x10437ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by main.(*App).withAppPlayer in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/main.go:277 +0x4c4 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 8 gp=0x1114c68 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025dd8, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1043de8 sp=0x1043dd4 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025dc8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1043e00 sp=0x1043de8 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025dc8, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1043e14 sp=0x1043e00 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1029d78, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1043e28 sp=0x1043e14 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Accept(0x1029d60) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1043e70 sp=0x1043e28 pc=0x10eb44 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).accept(0x1029d60) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1043ed8 sp=0x1043e70 pc=0x17e32c Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPListener).accept(0x1453848) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1043ef0 sp=0x1043ed8 pc=0x19642c Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPListener).Accept(0x1453848) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1043f0c sp=0x1043ef0 pc=0x195498 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*onceCloseListener).Accept(0x14bde00) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x34 fp=0x1043f24 sp=0x1043f0c pc=0x362680 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Server).Serve(0x10aa468, {0x7d6e18, 0x1453848}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1043fbc sp=0x1043f24 pc=0x340d3c Jun 22 09:12:19 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 22 09:12:19 volumio go-librespot[1201]: net/http.Serve(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2794 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Jun 22 09:12:19 volumio go-librespot[1201]: /src/zeroconf/zeroconf.go:267 +0x8c fp=0x1043fec sp=0x1043fbc pc=0x55de30 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1043fec sp=0x1043fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/zeroconf/zeroconf.go:267 +0x160 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 53 gp=0x1500368 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025d38, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11cce84 sp=0x11cce70 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025d28, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x11cce9c sp=0x11cce84 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025d28, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x11cceb0 sp=0x11cce9c pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1029dc8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11ccec4 sp=0x11cceb0 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).RawRead(0x1029db0, 0x109a660) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x11ccef0 sp=0x11ccec4 pc=0x10f748 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*rawConn).Read(0x149ecf0, 0x109a660) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x11ccf10 sp=0x11ccef0 pc=0x190854 Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x13780b0, 0x109a630, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x11ccf40 sp=0x11ccf10 pc=0x4fe72c Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x10014a8, {0x11ea000, 0x10000, 0x10000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x11ccf9c sp=0x11ccf40 pc=0x502714 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/grandcat/zeroconf.(*Server).recv4(0x1405d80, 0x10014a0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x11ccfe0 sp=0x11ccf9c pc=0x558fa4 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x11ccfec sp=0x11ccfe0 pc=0x558c5c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11ccfec sp=0x11ccfec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 4 Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 54 gp=0x1500488 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025c98, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1044e5c sp=0x1044e48 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025c88, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1044e74 sp=0x1044e5c pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025c88, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1044e88 sp=0x1044e74 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1029e18, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1044e9c sp=0x1044e88 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).RawRead(0x1029e00, 0x10f8030) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1044ec8 sp=0x1044e9c pc=0x10f748 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*rawConn).Read(0x149ed18, 0x10f8030) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1044ee8 sp=0x1044ec8 pc=0x190854 Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x13780f0, 0x10f8000, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1044f18 sp=0x1044ee8 pc=0x4fe72c Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Jun 22 09:12:19 volumio go-librespot[1201]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x10014d8, {0x11da000, 0x10000, 0x10000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x1044f9c sp=0x1044f18 pc=0x50609c Jun 22 09:12:19 volumio go-librespot[1201]: github.com/grandcat/zeroconf.(*Server).recv6(0x1405d80, 0x10014d0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x1044fe0 sp=0x1044f9c pc=0x559198 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x1044fec sp=0x1044fe0 pc=0x558c00 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1044fec sp=0x1044fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 4 Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 61 gp=0x1500b48 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x111b6a8 sp=0x111b694 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x111b7a4, 0x111b76c, 0x0, 0x0, 0x5, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x111b748 sp=0x111b6a8 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x11aa3c8) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x111b7e4 sp=0x111b748 pc=0x46d7fc Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.newConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x111b7ec sp=0x111b7e4 pc=0x46d3f0 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x111b7ec sp=0x111b7ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by nhooyr.io/websocket.newConn in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 28 gp=0x1500d88 m=nil [IO wait]: Jun 22 09:12:19 volumio systemd[1]: Startup finished in 11.955s (kernel) + 42.588s (userspace) = 54.544s. Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025b58, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11cfad4 sp=0x11cfac0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025b48, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x11cfaec sp=0x11cfad4 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025b48, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x11cfb00 sp=0x11cfaec pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1301a58, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11cfb14 sp=0x11cfb00 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x1301a40, {0x12f5000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x11cfb5c sp=0x11cfb14 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x1301a40, {0x12f5000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x11cfb88 sp=0x11cfb5c pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1095d38, {0x12f5000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x11cfbb4 sp=0x11cfb88 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1095d38, {0x12f5000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x11cfbd4 sp=0x11cfbb4 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x100f1d0, {0x12f5000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x11cfc00 sp=0x11cfbd4 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x122714c, {0x7d4554, 0x100f1d0}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x11cfc3c sp=0x11cfc00 pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x1226fc8, {0x7d373c, 0x1095d38}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x11cfc64 sp=0x11cfc3c pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x1226fc8, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x11cfdc8 sp=0x11cfc64 pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x1226fc8, {0x1387000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x11cfdf8 sp=0x11cfdc8 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Read(0x13807b0, {0x1208224, 0x9, 0x9}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x11cfe1c sp=0x11cfdf8 pc=0x2bdf6c Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAtLeast({0x7d3930, 0x13807b0}, {0x1208224, 0x9, 0x9}, 0x9) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x11cfe48 sp=0x11cfe1c pc=0x104280 Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadFull(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:354 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.http2readFrameHeader({0x1208224, 0x9, 0x9}, {0x7d3930, 0x13807b0}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x11cfe70 sp=0x11cfe48 pc=0x2f6e68 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Framer).ReadFrame(0x1208200) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x11cfeec sp=0x11cfe70 pc=0x2f7600 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2clientConnReadLoop).run(0x11cffdc) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x11cffa4 sp=0x11cfeec pc=0x31be1c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2ClientConn).readLoop(0x112d608) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x11cffe4 sp=0x11cffa4 pc=0x31b310 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*http2Transport).newClientConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x11cffec sp=0x11cffe4 pc=0x31435c Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11cffec sp=0x11cffec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*http2Transport).newClientConn in goroutine 27 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 80 gp=0x1085208 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12a4ea8 sp=0x12a4e94 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x12a4fa4, 0x12a4f6c, 0x0, 0x0, 0x5, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x12a4f48 sp=0x12a4ea8 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x11aab48) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x12a4fe4 sp=0x12a4f48 pc=0x46d7fc Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.newConn.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x12a4fec sp=0x12a4fe4 pc=0x46d3f0 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12a4fec sp=0x12a4fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by nhooyr.io/websocket.newConn in goroutine 78 Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 48 gp=0x10847e8 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11d5e74 sp=0x11d5e60 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x11d5f74, 0x11d5f3c, 0x0, 0x0, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x11d5f14 sp=0x11d5e74 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1098a00) Jun 22 09:12:19 volumio go-librespot[1201]: /src/player/player.go:181 +0x1fc fp=0x11d5fe4 sp=0x11d5f14 pc=0x4cbbd8 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/player/player.go:163 +0x28 fp=0x11d5fec sp=0x11d5fe4 pc=0x4cb7b8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11d5fec sp=0x11d5fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Jun 22 09:12:19 volumio go-librespot[1201]: /src/player/player.go:163 +0x1c8 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 78 gp=0x11159e8 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb60258d8, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x105787c sp=0x1057868 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb60258c8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1057894 sp=0x105787c pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb60258c8, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x10578a8 sp=0x1057894 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x13e30f8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x10578bc sp=0x10578a8 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x13e30e0, {0x11fa000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1057904 sp=0x10578bc pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x13e30e0, {0x11fa000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1057930 sp=0x1057904 pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x149f520, {0x11fa000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x105795c sp=0x1057930 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x149f520, {0x11fa000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x105797c sp=0x105795c pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: io.(*multiReader).Read(0x12e01f0, {0x11fa000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x10579a8 sp=0x105797c pc=0x1054e8 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).fill(0x11b23f0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x10579cc sp=0x10579a8 pc=0x2bd8e0 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).ReadByte(0x11b23f0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x10579d8 sp=0x10579cc pc=0x2be164 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.readFrameHeader(0x11b23f0, {0x11aab78, 0x8, 0x8}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1057a18 sp=0x10579d8 pc=0x470950 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x11aab48, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1057ad8 sp=0x1057a18 pc=0x4735b4 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).readLoop(0x11aab48, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1057b9c sp=0x1057ad8 pc=0x47309c Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).reader(0x11aab48, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1057c28 sp=0x1057b9c pc=0x4742b0 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).Reader(...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).Read(0x11aab48, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1057c50 sp=0x1057c28 pc=0x472980 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*ConcreteApiServer).serve.func17({0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/api_server.go:580 +0x3c0 fp=0x1057ccc sp=0x1057c50 pc=0x5e9490 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.HandlerFunc.ServeHTTP(0x10301d8, {0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1057cdc sp=0x1057ccc pc=0x33d320 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*ServeMux).ServeHTTP(0x1208080, {0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1057d18 sp=0x1057cdc pc=0x33f180 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1057d40 sp=0x1057d18 pc=0x5e8e90 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.HandlerFunc.ServeHTTP(0x100e210, {0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1057d50 sp=0x1057d40 pc=0x33d320 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.serverHandler.ServeHTTP({0x107a148}, {0x7d6f4c, 0x11fc288}, 0x11fc1e8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1057d6c sp=0x1057d50 pc=0x340910 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*conn).serve(0x115e720, {0x7d7654, 0x1026240}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1057fdc sp=0x1057d6c pc=0x33bb60 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Server).Serve.gowrap3() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1057fec sp=0x1057fdc pc=0x3411b4 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1057fec sp=0x1057fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*Server).Serve in goroutine 37 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/server.go:3285 +0x468 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 62 gp=0x1500ea8 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025ab8, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11ced14 sp=0x11ced00 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025aa8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x11ced2c sp=0x11ced14 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025aa8, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x11ced40 sp=0x11ced2c pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1102b58, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x11ced54 sp=0x11ced40 pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x1102b40, {0x1384894, 0x3, 0x3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x11ced9c sp=0x11ced54 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x1102b40, {0x1384894, 0x3, 0x3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x11cedc8 sp=0x11ced9c pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1095e00, {0x1384894, 0x3, 0x3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x11cedf4 sp=0x11cedc8 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1095e00, {0x1384894, 0x3, 0x3}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x11cee14 sp=0x11cedf4 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAtLeast({0x7d373c, 0x1095e00}, {0x1384894, 0x3, 0x3}, 0x3) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x11cee40 sp=0x11cee14 pc=0x104280 Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadFull(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:354 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x1112640, {0x7d7634, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/shannon.go:124 +0x3a0 fp=0x11cef04 sp=0x11cee40 pc=0x488a10 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x127e008) Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:276 +0x68 fp=0x11cefe4 sp=0x11cef04 pc=0x485188 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:260 +0x28 fp=0x11cefec sp=0x11cefe4 pc=0x4850f4 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11cefec sp=0x11cefec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:260 +0x98 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 63 gp=0x1500fc8 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12a46b8 sp=0x12a46a4 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x12a47d4, 0x12a477c, 0x0, 0x0, 0x2, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x12a4758 sp=0x12a46b8 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x127e008) Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:355 +0x8c fp=0x12a47e4 sp=0x12a4758 pc=0x4859a8 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:264 +0x28 fp=0x12a47ec sp=0x12a47e4 pc=0x4850a0 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12a47ec sp=0x12a47ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/ap/ap.go:264 +0x15c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 64 gp=0x15010e8 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025bf8, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1219940 sp=0x121992c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025be8, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1219958 sp=0x1219940 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025be8, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x121996c sp=0x1219958 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x13e3558, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1219980 sp=0x121996c pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x13e3540, {0x11fe000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x12199c8 sp=0x1219980 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x13e3540, {0x11fe000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x12199f4 sp=0x12199c8 pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1358398, {0x11fe000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1219a20 sp=0x12199f4 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1358398, {0x11fe000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x1219a40 sp=0x1219a20 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x1379320, {0x11fe000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1219a6c sp=0x1219a40 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x10a9a4c, {0x7d4554, 0x1379320}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1219aa8 sp=0x1219a6c pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x10a98c8, {0x7d373c, 0x1358398}, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1219ad0 sp=0x1219aa8 pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x10a98c8, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1219c34 sp=0x1219ad0 pc=0x279b08 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x10a98c8, {0x12ba000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1219c64 sp=0x1219c34 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*readWriteCloserBody).Read(0x1378fc0, {0x12ba000, 0x1000, 0x1000}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2429 +0xec fp=0x1219c84 sp=0x1219c64 pc=0x35762c Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).fill(0x10f8060) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1219ca8 sp=0x1219c84 pc=0x2bd8e0 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).ReadByte(0x10f8060) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x1219cb4 sp=0x1219ca8 pc=0x2be164 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.readFrameHeader(0x10f8060, {0x11aa3f8, 0x8, 0x8}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1219cf4 sp=0x1219cb4 pc=0x470950 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x11aa3c8, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1219db4 sp=0x1219cf4 pc=0x4735b4 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).readLoop(0x11aa3c8, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1219e78 sp=0x1219db4 pc=0x47309c Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).reader(0x11aa3c8, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1219f04 sp=0x1219e78 pc=0x4742b0 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).Reader(...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Jun 22 09:12:19 volumio go-librespot[1201]: nhooyr.io/websocket.(*Conn).Read(0x11aa3c8, {0x7d7614, 0xbf6000}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1219f2c sp=0x1219f04 pc=0x472980 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x12f2008) Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:188 +0x58 fp=0x1219fe4 sp=0x1219f2c pc=0x4e8b14 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:125 +0x28 fp=0x1219fec sp=0x1219fe4 pc=0x4ea5e8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1219fec sp=0x1219fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:125 +0x98 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 65 gp=0x1501208 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x12a5698 sp=0x12a5684 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x12a57d4, 0x12a5760, 0x0, 0x0, 0x2, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x12a5738 sp=0x12a5698 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x12f2008) Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:138 +0x8c fp=0x12a57e4 sp=0x12a5738 pc=0x4e868c Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:129 +0x28 fp=0x12a57ec sp=0x12a57e4 pc=0x4ea594 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x12a57ec sp=0x12a57ec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/dealer/dealer.go:129 +0x15c Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 86 gp=0x12df0e8 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x105acb0 sp=0x105ac9c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x105ae14, 0x105ad80, 0x0, 0x0, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x105ad50 sp=0x105acb0 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).recvLoop(0x137c420) Jun 22 09:12:19 volumio go-librespot[1201]: /src/audio/provider.go:63 +0x118 fp=0x105afe4 sp=0x105ad50 pc=0x48c7fc Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/audio/provider.go:53 +0x28 fp=0x105afec sp=0x105afe4 pc=0x48d524 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x105afec sp=0x105afec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1 in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/audio/provider.go:53 +0x60 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 119 gp=0x13d8b48 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x11caeb0 sp=0x11cae9c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x11cafac, 0x11caf78, 0x0, 0x0, 0x2, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x11caf50 sp=0x11caeb0 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).writeLoop(0x10ea378) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2444 +0xd0 fp=0x11cafe4 sp=0x11caf50 pc=0x357748 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Transport).dialConn.gowrap3() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1800 +0x28 fp=0x11cafec sp=0x11cafe4 pc=0x354554 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x11cafec sp=0x11cafec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*Transport).dialConn in goroutine 81 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1800 +0x1444 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 165 gp=0x10858c8 m=nil [IO wait]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736854, 0xb6025658, 0x2, 0x2, 0x5) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1472870 sp=0x147285c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.netpollblock(0xb6025648, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1472888 sp=0x1472870 pc=0x547d4 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.runtime_pollWait(0xb6025648, 0x72) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x147289c sp=0x1472888 pc=0x8f388 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).wait(0x1102478, 0x72, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x14728b0 sp=0x147289c pc=0x10a2d8 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*pollDesc).waitRead(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jun 22 09:12:19 volumio go-librespot[1201]: internal/poll.(*FD).Read(0x1102460, {0x15acc4d, 0x73b3, 0x73b3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x14728f8 sp=0x14728b0 pc=0x10b4c4 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*netFD).Read(0x1102460, {0x15acc4d, 0x73b3, 0x73b3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1472924 sp=0x14728f8 pc=0x17c438 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*conn).Read(0x1094468, {0x15acc4d, 0x73b3, 0x73b3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1472950 sp=0x1472924 pc=0x18c618 Jun 22 09:12:19 volumio go-librespot[1201]: net.(*TCPConn).Read(0x1094468, {0x15acc4d, 0x73b3, 0x73b3}) Jun 22 09:12:19 volumio go-librespot[1201]: :1 +0x44 fp=0x1472970 sp=0x1472950 pc=0x19f86c Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*atLeastReader).Read(0x133a360, {0x15acc4d, 0x73b3, 0x73b3}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x147299c sp=0x1472970 pc=0x27c1ac Jun 22 09:12:19 volumio go-librespot[1201]: bytes.(*Buffer).ReadFrom(0x13f284c, {0x7d4554, 0x133a360}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x14729d8 sp=0x147299c pc=0x139b90 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readFromUntil(0x13f26c8, {0x7d373c, 0x1094468}, 0x4016) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1472a00 sp=0x14729d8 pc=0x27c408 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecordOrCCS(0x13f26c8, 0x0) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:677 +0xa10 fp=0x1472b64 sp=0x1472a00 pc=0x27a3e4 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).readRecord(...) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:588 Jun 22 09:12:19 volumio go-librespot[1201]: crypto/tls.(*Conn).Read(0x13f26c8, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1472b94 sp=0x1472b64 pc=0x27f978 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).Read(0x12f20b8, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1977 +0x16c fp=0x1472bc8 sp=0x1472b94 pc=0x3550f8 Jun 22 09:12:19 volumio go-librespot[1201]: bufio.(*Reader).Read(0x1000060, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/bufio/bufio.go:227 +0x12c fp=0x1472bec sp=0x1472bc8 pc=0x2bde84 Jun 22 09:12:19 volumio go-librespot[1201]: io.(*LimitedReader).Read(0x1106030, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:479 +0xc4 fp=0x1472c0c sp=0x1472bec pc=0x104a48 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*body).readLocked(0x13d4000, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transfer.go:840 +0x4c fp=0x1472c38 sp=0x1472c0c pc=0x34a4b4 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*body).Read(0x13d4000, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transfer.go:832 +0xe8 fp=0x1472c6c sp=0x1472c38 pc=0x34a3c0 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*bodyEOFSignal).Read(0x13d4030, {0x14e522b, 0x2dd5, 0x2dd5}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2833 +0xc0 fp=0x1472ca8 sp=0x1472c6c pc=0x3592dc Jun 22 09:12:19 volumio go-librespot[1201]: io.ReadAll({0x7d38a4, 0x13d4030}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/io/io.go:712 +0x84 fp=0x1472ce4 sp=0x1472ca8 pc=0x1052b8 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/audio.NewHttpChunkedReader({0x7d9b30, 0x11be240}, 0x1109080, {0x108e280, 0x80}) Jun 22 09:12:19 volumio go-librespot[1201]: /src/audio/chunked_reader.go:100 +0x54c fp=0x1472d50 sp=0x1472ce4 pc=0x48ab50 Jun 22 09:12:19 volumio go-librespot[1201]: github.com/devgianlu/go-librespot/player.(*Player).NewStream(0x1098a00, {0x7d7634, 0xbf6000}, 0x1109080, {{0x10ae218, 0x5}, {0x1384360, 0x10, 0x10}}, 0x140, ...) Jun 22 09:12:19 volumio go-librespot[1201]: /src/player/player.go:489 +0x768 fp=0x1472e8c sp=0x1472d50 pc=0x4ccf38 Jun 22 09:12:19 volumio go-librespot[1201]: main.(*AppPlayer).prefetchNext(0x13000a0) Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/controls.go:45 +0x254 fp=0x1472fe4 sp=0x1472e8c pc=0x5eb2ec Jun 22 09:12:19 volumio go-librespot[1201]: main.(*AppPlayer).schedulePrefetchNext.gowrap1() Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/controls.go:69 +0x28 fp=0x1472fec sp=0x1472fe4 pc=0x5ebd94 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1472fec sp=0x1472fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by main.(*AppPlayer).schedulePrefetchNext in goroutine 49 Jun 22 09:12:19 volumio go-librespot[1201]: /src/cmd/daemon/controls.go:69 +0x1c8 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 92 gp=0x10859e8 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x105bde4 sp=0x105bdd0 pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x105bf78, 0x105bebc, 0x0, 0x0, 0x4, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x105be84 sp=0x105bde4 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).readLoop(0x12f20b8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2261 +0xc68 fp=0x105bfe4 sp=0x105be84 pc=0x35675c Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Transport).dialConn.gowrap2() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1799 +0x28 fp=0x105bfec sp=0x105bfe4 pc=0x3545a8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x105bfec sp=0x105bfec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*Transport).dialConn in goroutine 16 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1799 +0x13f4 Jun 22 09:12:19 volumio go-librespot[1201]: goroutine 93 gp=0x12df9e8 m=nil [select]: Jun 22 09:12:19 volumio go-librespot[1201]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1054eb0 sp=0x1054e9c pc=0x5cfc8 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.selectgo(0x1054fac, 0x1054f78, 0x0, 0x0, 0x2, 0x1) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1054f50 sp=0x1054eb0 pc=0x70d80 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*persistConn).writeLoop(0x12f20b8) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:2444 +0xd0 fp=0x1054fe4 sp=0x1054f50 pc=0x357748 Jun 22 09:12:19 volumio go-librespot[1201]: net/http.(*Transport).dialConn.gowrap3() Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1800 +0x28 fp=0x1054fec sp=0x1054fe4 pc=0x354554 Jun 22 09:12:19 volumio go-librespot[1201]: runtime.goexit({}) Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1054fec sp=0x1054fec pc=0x93c4c Jun 22 09:12:19 volumio go-librespot[1201]: created by net/http.(*Transport).dialConn in goroutine 16 Jun 22 09:12:19 volumio go-librespot[1201]: /usr/local/go/src/net/http/transport.go:1800 +0x1444 Jun 22 09:12:19 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Jun 22 09:12:19 volumio go-librespot[1201]: Aborted Jun 22 09:12:19 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 22 09:12:19 volumio sudo[1407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 09:11 Jun 22 09:12:19 volumio sudo[1407]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"