-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-07-06 20:42:39 CEST. -- Jul 06 20:41:00 bladelius go-librespot[6250]: time="2025-07-06T20:41:00+02:00" level=trace msg="sent dealer ping" Jul 06 20:41:00 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:00 bladelius go-librespot[6250]: time="2025-07-06T20:41:00+02:00" level=trace msg="received dealer pong" Jul 06 20:41:01 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:02 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="dealer connection closed" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="dealer recv loop stopped" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="obtained new client token: AAAAlUINq4VOAxCmBTY92fKgQr5RPu1JgOcKS0qSiQyKyEllqX+K+CQ3H2b+BU6Z+o7VpODoZ0u/nlBwRf94+fa8joNPXjPn76UiGIa521Uh2ZIJKb7E3FAyzFQs+cQK4qR+KcLVcoynDs+8+UztZfTD0wy8J48yd9EJ8SP/1uuOL51XBI8+iVOMIfciPCYOnpw8pddFVN4MvWg/eE8hNFzZDOYGMbSBKgRHKgFqymPLrmCDmCKheFjoKQ==" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="completed keyexchange" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="completed challenge" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=info msg="authenticated AP as alfeifrode" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=info msg="authenticated Login5 as alfeifrode" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=info msg="accepted zeroconf user alfeifrode from iPhone" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="dealer connection opened" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=trace msg="starting accesspoint recv loop" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=trace msg="starting dealer recv loop" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=trace msg="received accesspoint ping" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jul 06 20:41:03 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=debug msg="received connection id: MjZkNTYyMWQtNGUxNC00ZmRjLWE1YWQtMjhhN2I1MjMxMWIxK2RlYWxlcit0Y3A6Ly8wYWIxNTIxYi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArRDQ2QjU2NEI2Njc4NTE5OTBBMjQwNTdGOUE1NDkwODE5Q0ZDNDcwRTYxOUI2RTlEODBENzIzQjBDM0NCNTE1RA==" Jul 06 20:41:03 bladelius go-librespot[6250]: time="2025-07-06T20:41:03+02:00" level=trace msg="received accesspoint pong ack" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="put connect state because NEW_DEVICE" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="update volume to 65535/65535" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="handling transfer player command from 2036e45961391ae2414fcebcf12d70bf6838a8d8" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="resolved context of track" uri="spotify:playlist:5kMIiuvN3a7v6rEeB3zf8N" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=trace msg="fetched new page 0 with 137 items (list: 137)" uri="spotify:playlist:5kMIiuvN3a7v6rEeB3zf8N" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="loading track (paused: false, position: 31379ms)" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=trace msg="emitting websocket event: will_play" Jul 06 20:41:04 bladelius volumio[974]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:69aZorSTHYTJb3tupO6NDW","play_origin":"playlist/ondemand"}} Jul 06 20:41:04 bladelius volumio[974]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:69aZorSTHYTJb3tupO6NDW","play_origin":"playlist/ondemand"}} Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="selected format OGG_VORBIS_320 (ab7384941a22f98901d71e88cc551d460e3a3106)" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="requested aes key for file ab7384941a22f98901d71e88cc551d460e3a3106, gid: 69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1342" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched first chunk of 20, total size is 10097156 bytes" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=warning msg="reducing track normalisation factor to prevent clipping, please add negative pregain to avoid" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1116" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched chunk 2/19, size: 524288" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=trace msg="seek to 31379ms (diff: 168ms, samples: 1383813, bytes: 1156892)" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="created new output device" Jul 06 20:41:04 bladelius go-librespot[6250]: ALSA lib /home/pi/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=warning msg="failed handling dealer request" error="failed loading current track (transfer): failed setting stream for spotify:track:69aZorSTHYTJb3tupO6NDW: ALSA error at snd_pcm_open: Device or resource busy" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched chunk 4/19, size: 524288" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched chunk 3/19, size: 524288" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched chunk 5/19, size: 524288" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius go-librespot[6250]: time="2025-07-06T20:41:04+02:00" level=debug msg="fetched chunk 1/19, size: 524288" uri="spotify:track:69aZorSTHYTJb3tupO6NDW" Jul 06 20:41:04 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:05 bladelius go-librespot[6250]: time="2025-07-06T20:41:05+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Jul 06 20:41:05 bladelius go-librespot[6250]: time="2025-07-06T20:41:05+02:00" level=trace msg="emitting websocket event: volume" Jul 06 20:41:05 bladelius volumio[974]: SPOTIFY: received: {"type":"volume","data":{"value":100,"max":100}} Jul 06 20:41:05 bladelius volumio[974]: SPOTIFY: RECEIVED SPOTIFY VOLUME 100 Jul 06 20:41:05 bladelius volumio[974]: SPOTIFY: received: {"type":"volume","data":{"value":100,"max":100}} Jul 06 20:41:05 bladelius volumio[974]: SPOTIFY: RECEIVED SPOTIFY VOLUME 100 Jul 06 20:41:05 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:06 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:07 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:08 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:09 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:10 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:11 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:12 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:13 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:14 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:15 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:16 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:17 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:18 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:19 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:20 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:21 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:22 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:23 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:24 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:25 bladelius bladelius[697]: Current volume is: 21 Jul 06 20:41:25 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:26 bladelius bladelius[697]: Current volume is: 20 Jul 06 20:41:26 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:27 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:28 bladelius bladelius[697]: Current volume is: 19 Jul 06 20:41:28 bladelius bladelius[697]: Current volume is: 18 Jul 06 20:41:28 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:28 bladelius bladelius[697]: Current volume is: 17 Jul 06 20:41:29 bladelius bladelius[697]: Current volume is: 16 Jul 06 20:41:29 bladelius bladelius[697]: Current volume is: 15 Jul 06 20:41:29 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:30 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:31 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:32 bladelius go-librespot[6250]: time="2025-07-06T20:41:32+02:00" level=debug msg="handling pause player command from 2036e45961391ae2414fcebcf12d70bf6838a8d8" Jul 06 20:41:32 bladelius go-librespot[6250]: time="2025-07-06T20:41:32+02:00" level=warning msg="failed getting output device delay" error="ALSA error at snd_pcm_delay: Input/output error" Jul 06 20:41:32 bladelius go-librespot[6250]: time="2025-07-06T20:41:32+02:00" level=debug msg="pause track at 31211ms" Jul 06 20:41:32 bladelius go-librespot[6250]: SIGSEGV: segmentation violation Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0xb6e9f840 m=3 sigcode=1 addr=0x18 Jul 06 20:41:32 bladelius go-librespot[6250]: signal arrived during cgo execution Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12479 gp=0x18d3568 m=3 mp=0x1448b08 [syscall]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.cgocall(0x5ff278, 0x145becc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/cgocall.go:157 +0x50 fp=0x145beb4 sp=0x145be9c pc=0x1d728 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/output._Cfunc_snd_pcm_close(0xb2201f00) Jul 06 20:41:32 bladelius go-librespot[6250]: _cgo_gotypes.go:415 +0x38 fp=0x145bec8 sp=0x145beb4 pc=0x49bb3c Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/output.(*alsaOutput).Pause.func1(0x184e180) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/output/driver-alsa.go:342 +0x50 fp=0x145bee4 sp=0x145bec8 pc=0x49f8c0 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/output.(*alsaOutput).Pause(0x184e180) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/output/driver-alsa.go:342 +0xc0 fp=0x145bf14 sp=0x145bee4 pc=0x49f7c8 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1760080) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/player/player.go:244 +0x94c fp=0x145bfe4 sp=0x145bf14 pc=0x4cc328 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/player/player.go:163 +0x28 fp=0x145bfec sp=0x145bfe4 pc=0x4cb7b8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x145bfec sp=0x145bfec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/player/player.go:163 +0x1c8 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 1 gp=0x1402128 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d86cfc sp=0x1d86ce8 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x1d86dfc, 0x1daddc8, 0x0, 0x0, 0x2, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1d86d9c sp=0x1d86cfc pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x161a000, 0x1d86e88) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/zeroconf/zeroconf.go:270 +0x228 fp=0x1d86e40 sp=0x1d86d9c pc=0x55dd34 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).withAppPlayer(0x158c200, {0x7d7634, 0xbf6000}, 0x140eb70) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:316 +0x514 fp=0x1d86ec8 sp=0x1d86e40 pc=0x5f2dcc Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).withCredentials(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:190 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).SpotifyToken(0x158c200, {0x7d7634, 0xbf6000}, {0x1410090, 0xb}, {0x147c000, 0x118}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:182 +0xd8 fp=0x1d86ef8 sp=0x1d86ec8 pc=0x5f22c0 Jul 06 20:41:32 bladelius go-librespot[6250]: main.main() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:618 +0x61c fp=0x1d86fa8 sp=0x1d86ef8 pc=0x5f5a58 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.main() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x1d86fec sp=0x1d86fa8 pc=0x5ca38 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d86fec sp=0x1d86fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 2 gp=0x14027e8 m=nil [force gc (idle), 3 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736864, 0xbca928, 0x11, 0xa, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1444fd4 sp=0x1444fc0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goparkunlock(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:408 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.forcegchelper() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1444fec sp=0x1444fd4 pc=0x5ce04 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1444fec sp=0x1444fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.init.5 in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:314 +0x1c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 18 gp=0x1484248 m=nil [GC sweep wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736864, 0xbcaee0, 0xc, 0x9, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14407c4 sp=0x14407b0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goparkunlock(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:408 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.bgsweep(0x146c000) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x14407e4 sp=0x14407c4 pc=0x45750 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcenable.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x14407ec sp=0x14407e4 pc=0x35870 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14407ec sp=0x14407ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcenable in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 19 gp=0x1484368 m=nil [GC scavenge wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736864, 0xbcb508, 0xd, 0xa, 0x2) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1440fb4 sp=0x1440fa0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goparkunlock(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:408 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.(*scavengerState).park(0xbcb508) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1440fc8 sp=0x1440fb4 pc=0x42a70 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.bgscavenge(0x146c000) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1440fe4 sp=0x1440fc8 pc=0x431a8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcenable.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1440fec sp=0x1440fe4 pc=0x3581c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1440fec sp=0x1440fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcenable in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 20 gp=0x14846c8 m=nil [finalizer wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736710, 0xbf609c, 0x10, 0xa, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x144178c sp=0x1441778 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.runfinq() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x14417ec sp=0x144178c pc=0x3465c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14417ec sp=0x14417ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.createfing in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 5 gp=0x1403568 m=nil [IO wait, 88 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046f08, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1445d28 sp=0x1445d14 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046ef8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1445d40 sp=0x1445d28 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046ef8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1445d54 sp=0x1445d40 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x1428518, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1445d68 sp=0x1445d54 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Accept(0x1428500) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1445db0 sp=0x1445d68 pc=0x10eb44 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).accept(0x1428500) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1445e18 sp=0x1445db0 pc=0x17e32c Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPListener).accept(0x14264f8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1445e30 sp=0x1445e18 pc=0x19642c Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPListener).Accept(0x14264f8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1445e4c sp=0x1445e30 pc=0x195498 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*onceCloseListener).Accept(0x1614340) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x34 fp=0x1445e64 sp=0x1445e4c pc=0x362680 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Server).Serve(0x160c0a8, {0x7d6e18, 0x14264f8}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1445efc sp=0x1445e64 pc=0x340d3c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.Serve(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2794 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*ConcreteApiServer).serve(0x158e060) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/api_server.go:610 +0x974 fp=0x1445fe4 sp=0x1445efc pc=0x5e8bc0 Jul 06 20:41:32 bladelius go-librespot[6250]: main.NewApiServer.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/api_server.go:289 +0x28 fp=0x1445fec sp=0x1445fe4 pc=0x5e7a90 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1445fec sp=0x1445fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by main.NewApiServer in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/api_server.go:289 +0x310 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 35 gp=0x14038c8 m=nil [GC worker (idle)]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736720, 0x142a258, 0x1a, 0xa, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1445790 sp=0x144577c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcBgMarkWorker() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x14457ec sp=0x1445790 pc=0x38498 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14457ec sp=0x14457ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 11 gp=0x1403c28 m=nil [GC worker (idle)]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736720, 0x142a270, 0x1a, 0xa, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1446790 sp=0x144677c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcBgMarkWorker() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x14467ec sp=0x1446790 pc=0x38498 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14467ec sp=0x14467ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12 gp=0x1403d48 m=nil [GC worker (idle)]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736720, 0x142a288, 0x1a, 0xa, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1446f90 sp=0x1446f7c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcBgMarkWorker() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1446fec sp=0x1446f90 pc=0x38498 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1446fec sp=0x1446fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 13 gp=0x1403e68 m=nil [GC worker (idle)]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736720, 0x142a2a0, 0x1a, 0xa, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1447790 sp=0x144777c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcBgMarkWorker() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x14477ec sp=0x1447790 pc=0x38498 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14477ec sp=0x14477ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 21 gp=0x14847e8 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046d28, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1866e84 sp=0x1866e70 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046d18, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1866e9c sp=0x1866e84 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046d18, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1866eb0 sp=0x1866e9c pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x161e108, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1866ec4 sp=0x1866eb0 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).RawRead(0x161e0f0, 0x18d4000) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1866ef0 sp=0x1866ec4 pc=0x10f748 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*rawConn).Read(0x160a518, 0x18d4000) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1866f10 sp=0x1866ef0 pc=0x190854 Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x16d0220, 0x15a9ec0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1866f40 sp=0x1866f10 pc=0x4fe72c Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x186c098, {0x16a4000, 0x10000, 0x10000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x1866f9c sp=0x1866f40 pc=0x502714 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/grandcat/zeroconf.(*Server).recv4(0x158c880, 0x186c090) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1866fe0 sp=0x1866f9c pc=0x558fa4 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1866fec sp=0x1866fe0 pc=0x558c5c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1866fec sp=0x1866fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 36 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 22 gp=0x1484908 m=nil [IO wait, 93 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046c88, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x159065c sp=0x1590648 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046c78, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1590674 sp=0x159065c pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046c78, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1590688 sp=0x1590674 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x161e158, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x159069c sp=0x1590688 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).RawRead(0x161e140, 0x169e030) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x15906c8 sp=0x159069c pc=0x10f748 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*rawConn).Read(0x160a540, 0x169e030) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x15906e8 sp=0x15906c8 pc=0x190854 Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x16d0230, 0x169e000, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1590718 sp=0x15906e8 pc=0x4fe72c Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Jul 06 20:41:32 bladelius go-librespot[6250]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x186c0c8, {0x168e000, 0x10000, 0x10000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x159079c sp=0x1590718 pc=0x50609c Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/grandcat/zeroconf.(*Server).recv6(0x158c880, 0x186c0c0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x15907e0 sp=0x159079c pc=0x559198 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x15907ec sp=0x15907e0 pc=0x558c00 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15907ec sp=0x15907ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 36 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 60 gp=0x1631328 m=nil [chan receive, 88 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x7366f4, 0x146c130, 0xe, 0x7, 0x2) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1441f48 sp=0x1441f34 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv(0x146c100, 0x1441fd0, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1441f84 sp=0x1441f48 pc=0x1ff80 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv2(0x146c100, 0x1441fd0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1441f98 sp=0x1441f84 pc=0x1fac4 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).withAppPlayer.func1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:264 +0x68 fp=0x1441fec sp=0x1441f98 pc=0x5f3964 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1441fec sp=0x1441fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by main.(*App).withAppPlayer in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:261 +0x424 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 61 gp=0x1631448 m=nil [chan receive, 88 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x7366f4, 0x146c0f0, 0xe, 0x7, 0x2) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1948738 sp=0x1948724 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv(0x146c0c0, 0x1db1fe0, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1948774 sp=0x1948738 pc=0x1ff80 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv2(0x146c0c0, 0x1db1fe0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1948788 sp=0x1948774 pc=0x1fac4 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).withAppPlayer.func2() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:280 +0x6c fp=0x19487ec sp=0x1948788 pc=0x5f352c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x19487ec sp=0x19487ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by main.(*App).withAppPlayer in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:277 +0x4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 62 gp=0x1631568 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046dc8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1442de8 sp=0x1442dd4 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046db8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1442e00 sp=0x1442de8 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046db8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1442e14 sp=0x1442e00 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x161e0b8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1442e28 sp=0x1442e14 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Accept(0x161e0a0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1442e70 sp=0x1442e28 pc=0x10eb44 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).accept(0x161e0a0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1442ed8 sp=0x1442e70 pc=0x17e32c Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPListener).accept(0x16280f0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1442ef0 sp=0x1442ed8 pc=0x19642c Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPListener).Accept(0x16280f0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1442f0c sp=0x1442ef0 pc=0x195498 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*onceCloseListener).Accept(0x190a040) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x34 fp=0x1442f24 sp=0x1442f0c pc=0x362680 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Server).Serve(0x1581368, {0x7d6e18, 0x16280f0}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1442fbc sp=0x1442f24 pc=0x340d3c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.Serve(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2794 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/zeroconf/zeroconf.go:267 +0x8c fp=0x1442fec sp=0x1442fbc pc=0x55de30 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1442fec sp=0x1442fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/zeroconf/zeroconf.go:267 +0x160 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12950 gp=0x1631688 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d91ea8 sp=0x1d91e94 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x1d91fa4, 0x1d91f6c, 0x0, 0x0, 0x5, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1d91f48 sp=0x1d91ea8 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x15437c8) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1d91fe4 sp=0x1d91f48 pc=0x46d7fc Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.newConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1d91fec sp=0x1d91fe4 pc=0x46d3f0 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d91fec sp=0x1d91fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by nhooyr.io/websocket.newConn in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 90 gp=0x1631d48 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1592ea8 sp=0x1592e94 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x1592fa4, 0x1592f6c, 0x0, 0x0, 0x5, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1592f48 sp=0x1592ea8 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x1543048) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1592fe4 sp=0x1592f48 pc=0x46d7fc Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.newConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1592fec sp=0x1592fe4 pc=0x46d3f0 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1592fec sp=0x1592fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by nhooyr.io/websocket.newConn in goroutine 115 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 100 gp=0x1631e68 m=nil [IO wait, 93 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb60468c8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x181187c sp=0x1811868 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb60468b8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1811894 sp=0x181187c pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb60468b8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x18118a8 sp=0x1811894 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x14a63d8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x18118bc sp=0x18118a8 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x14a63c0, {0x18c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1811904 sp=0x18118bc pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x14a63c0, {0x18c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1811930 sp=0x1811904 pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x18da1c0, {0x18c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x181195c sp=0x1811930 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x18da1c0, {0x18c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x181197c sp=0x181195c pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: io.(*multiReader).Read(0x177a360, {0x18c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x18119a8 sp=0x181197c pc=0x1054e8 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).fill(0x15a9bf0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x18119cc sp=0x18119a8 pc=0x2bd8e0 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).ReadByte(0x15a9bf0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x18119d8 sp=0x18119cc pc=0x2be164 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.readFrameHeader(0x15a9bf0, {0x15ba3f8, 0x8, 0x8}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1811a18 sp=0x18119d8 pc=0x470950 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x15ba3c8, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1811ad8 sp=0x1811a18 pc=0x4735b4 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).readLoop(0x15ba3c8, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1811b9c sp=0x1811ad8 pc=0x47309c Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).reader(0x15ba3c8, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1811c28 sp=0x1811b9c pc=0x4742b0 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).Reader(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).Read(0x15ba3c8, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1811c50 sp=0x1811c28 pc=0x472980 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*ConcreteApiServer).serve.func17({0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/api_server.go:580 +0x3c0 fp=0x1811ccc sp=0x1811c50 pc=0x5e9490 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.HandlerFunc.ServeHTTP(0x160a180, {0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1811cdc sp=0x1811ccc pc=0x33d320 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*ServeMux).ServeHTTP(0x1600000, {0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1811d18 sp=0x1811cdc pc=0x33f180 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1811d40 sp=0x1811d18 pc=0x5e8e90 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.HandlerFunc.ServeHTTP(0x1604160, {0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1811d50 sp=0x1811d40 pc=0x33d320 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.serverHandler.ServeHTTP({0x160c0a8}, {0x7d6f4c, 0x14ae828}, 0x14ae788) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1811d6c sp=0x1811d50 pc=0x340910 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*conn).serve(0x17c4240, {0x7d7654, 0x1616180}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1811fdc sp=0x1811d6c pc=0x33bb60 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Server).Serve.gowrap3() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1811fec sp=0x1811fdc pc=0x3411b4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1811fec sp=0x1811fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Server).Serve in goroutine 5 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3285 +0x468 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 115 gp=0x1912008 m=nil [IO wait, 93 minutes]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046828, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x186787c sp=0x1867868 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046818, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1867894 sp=0x186787c pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046818, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x18678a8 sp=0x1867894 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x1428338, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x18678bc sp=0x18678a8 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x1428320, {0x191a000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1867904 sp=0x18678bc pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x1428320, {0x191a000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1867930 sp=0x1867904 pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x14301a8, {0x191a000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x186795c sp=0x1867930 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x14301a8, {0x191a000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x186797c sp=0x186795c pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: io.(*multiReader).Read(0x1717b00, {0x191a000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x18679a8 sp=0x186797c pc=0x1054e8 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).fill(0x178a330) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x18679cc sp=0x18679a8 pc=0x2bd8e0 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).ReadByte(0x178a330) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x18679d8 sp=0x18679cc pc=0x2be164 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.readFrameHeader(0x178a330, {0x1543078, 0x8, 0x8}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1867a18 sp=0x18679d8 pc=0x470950 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x1543048, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1867ad8 sp=0x1867a18 pc=0x4735b4 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).readLoop(0x1543048, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1867b9c sp=0x1867ad8 pc=0x47309c Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).reader(0x1543048, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1867c28 sp=0x1867b9c pc=0x4742b0 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).Reader(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).Read(0x1543048, {0x7d7614, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1867c50 sp=0x1867c28 pc=0x472980 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*ConcreteApiServer).serve.func17({0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/api_server.go:580 +0x3c0 fp=0x1867ccc sp=0x1867c50 pc=0x5e9490 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.HandlerFunc.ServeHTTP(0x160a180, {0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1867cdc sp=0x1867ccc pc=0x33d320 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*ServeMux).ServeHTTP(0x1600000, {0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1867d18 sp=0x1867cdc pc=0x33f180 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1867d40 sp=0x1867d18 pc=0x5e8e90 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.HandlerFunc.ServeHTTP(0x1604160, {0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1867d50 sp=0x1867d40 pc=0x33d320 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.serverHandler.ServeHTTP({0x160c0a8}, {0x7d6f4c, 0x160cfa8}, 0x1580288) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1867d6c sp=0x1867d50 pc=0x340910 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*conn).serve(0x14db020, {0x7d7654, 0x1616180}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1867fdc sp=0x1867d6c pc=0x33bb60 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Server).Serve.gowrap3() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1867fec sp=0x1867fdc pc=0x3411b4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1867fec sp=0x1867fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Server).Serve in goroutine 5 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/server.go:3285 +0x468 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 102 gp=0x181c248 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x15926a8 sp=0x1592694 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x15927a4, 0x159276c, 0x0, 0x0, 0x5, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1592748 sp=0x15926a8 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x15ba3c8) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x15927e4 sp=0x1592748 pc=0x46d7fc Jul 06 20:41:32 bladelius go-librespot[6250]: nhooyr.io/websocket.newConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x15927ec sp=0x15927e4 pc=0x46d3f0 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15927ec sp=0x15927ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by nhooyr.io/websocket.newConn in goroutine 100 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12951 gp=0x1912248 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046aa8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x186bd14 sp=0x186bd00 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046a98, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x186bd2c sp=0x186bd14 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046a98, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x186bd40 sp=0x186bd2c pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x16d5238, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x186bd54 sp=0x186bd40 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x16d5220, {0x1764e90, 0x3, 0x3}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x186bd9c sp=0x186bd54 pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x16d5220, {0x1764e90, 0x3, 0x3}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x186bdc8 sp=0x186bd9c pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1490740, {0x1764e90, 0x3, 0x3}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x186bdf4 sp=0x186bdc8 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1490740, {0x1764e90, 0x3, 0x3}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x186be14 sp=0x186bdf4 pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadAtLeast({0x7d373c, 0x1490740}, {0x1764e90, 0x3, 0x3}, 0x3) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x186be40 sp=0x186be14 pc=0x104280 Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadFull(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:354 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x1494a40, {0x7d7634, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/shannon.go:124 +0x3a0 fp=0x186bf04 sp=0x186be40 pc=0x488a10 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x16f2798) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:276 +0x68 fp=0x186bfe4 sp=0x186bf04 pc=0x485188 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:260 +0x28 fp=0x186bfec sp=0x186bfe4 pc=0x4850f4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x186bfec sp=0x186bfec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:260 +0x98 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12921 gp=0x174f328 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d85cb0 sp=0x1d85c9c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x1d85e14, 0x1d85d80, 0x0, 0x0, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1d85d50 sp=0x1d85cb0 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).recvLoop(0x17521c0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/audio/provider.go:63 +0x118 fp=0x1d85fe4 sp=0x1d85d50 pc=0x48c7fc Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/audio/provider.go:53 +0x28 fp=0x1d85fec sp=0x1d85fe4 pc=0x48d524 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d85fec sp=0x1d85fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/audio.(*KeyProvider).Request.(*KeyProvider).startReceiving.func1 in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/audio/provider.go:53 +0x60 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12480 gp=0x17e5c28 m=nil [chan receive]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x7366f4, 0x198d170, 0xe, 0x7, 0x2) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1db15c8 sp=0x1db15b4 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv(0x198d140, 0x1db1690, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1db1604 sp=0x1db15c8 pc=0x1ff80 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv1(0x198d140, 0x1db1690) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x1db1618 sp=0x1db1604 pc=0x1faa0 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/player.(*Player).Pause(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/player/player.go:362 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*AppPlayer).pause(0x186f900, {0x7d7634, 0xbf6000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/controls.go:392 +0x1ec fp=0x1db16a8 sp=0x1db1618 pc=0x5eee90 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*AppPlayer).handlePlayerCommand(0x186f900, {0x7d7634, 0xbf6000}, {0x610b2275, {0x17577a0, 0x28}, {{0x1411410, 0x5}, {0x0, 0x0}, ...}}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/player.go:279 +0x9f4 fp=0x1db17c0 sp=0x1db16a8 pc=0x5f76d4 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*AppPlayer).handleDealerRequest(0x186f900, {0x7d7634, 0xbf6000}, {0x181e600, {0x1757740, 0x24}, {0x610b2275, {0x17577a0, 0x28}, {{0x1411410, ...}, ...}}}) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/player.go:354 +0x11c fp=0x1db18f4 sp=0x1db17c0 pc=0x5f8fe8 Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*AppPlayer).Run(0x186f900, {0x7d7634, 0xbf6000}, 0x16101c0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/player.go:582 +0x55c fp=0x1db1fd8 sp=0x1db18f4 pc=0x5fb10c Jul 06 20:41:32 bladelius go-librespot[6250]: main.(*App).withAppPlayer.func3.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:352 +0x40 fp=0x1db1fec sp=0x1db1fd8 pc=0x5f3494 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1db1fec sp=0x1db1fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by main.(*App).withAppPlayer.func3 in goroutine 1 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/cmd/daemon/main.go:352 +0x50c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12998 gp=0x17f79e8 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb60466e8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1455afc sp=0x1455ae8 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb60466d8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1455b14 sp=0x1455afc pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb60466d8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1455b28 sp=0x1455b14 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x14a67e8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1455b3c sp=0x1455b28 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x14a67d0, {0x1a4c000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1455b84 sp=0x1455b3c pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x14a67d0, {0x1a4c000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1455bb0 sp=0x1455b84 pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1e94088, {0x1a4c000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1455bdc sp=0x1455bb0 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1e94088, {0x1a4c000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1455bfc sp=0x1455bdc pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x177a140, {0x1a4c000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1455c28 sp=0x1455bfc pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x162684c, {0x7d4554, 0x177a140}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1455c64 sp=0x1455c28 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x16266c8, {0x7d373c, 0x1e94088}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1455c8c sp=0x1455c64 pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x16266c8, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1455df0 sp=0x1455c8c pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x16266c8, {0x1ecd000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1455e20 sp=0x1455df0 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).Read(0x14f66e8, {0x1ecd000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1977 +0x16c fp=0x1455e54 sp=0x1455e20 pc=0x3550f8 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).fill(0x178a720) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1455e78 sp=0x1455e54 pc=0x2bd8e0 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Peek(0x178a720, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:148 +0x68 fp=0x1455e84 sp=0x1455e78 pc=0x2bda64 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).readLoop(0x14f66e8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:2141 +0x194 fp=0x1455fe4 sp=0x1455e84 pc=0x355c88 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Transport).dialConn.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1799 +0x28 fp=0x1455fec sp=0x1455fe4 pc=0x3545a8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1455fec sp=0x1455fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Transport).dialConn in goroutine 12979 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1799 +0x13f4 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12970 gp=0x15610e8 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046be8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d88ad4 sp=0x1d88ac0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046bd8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1d88aec sp=0x1d88ad4 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046bd8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1d88b00 sp=0x1d88aec pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x17af8c8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1d88b14 sp=0x1d88b00 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x17af8b0, {0x1803000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1d88b5c sp=0x1d88b14 pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x17af8b0, {0x1803000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1d88b88 sp=0x1d88b5c pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1e94160, {0x1803000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1d88bb4 sp=0x1d88b88 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1e94160, {0x1803000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1d88bd4 sp=0x1d88bb4 pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x177a170, {0x1803000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1d88c00 sp=0x1d88bd4 pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x178e60c, {0x7d4554, 0x177a170}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1d88c3c sp=0x1d88c00 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x178e488, {0x7d373c, 0x1e94160}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1d88c64 sp=0x1d88c3c pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x178e488, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1d88dc8 sp=0x1d88c64 pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x178e488, {0x1897000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1d88df8 sp=0x1d88dc8 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Read(0x18d5530, {0x168c6a4, 0x9, 0x9}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1d88e1c sp=0x1d88df8 pc=0x2bdf6c Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadAtLeast({0x7d3930, 0x18d5530}, {0x168c6a4, 0x9, 0x9}, 0x9) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1d88e48 sp=0x1d88e1c pc=0x104280 Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadFull(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:354 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.http2readFrameHeader({0x168c6a4, 0x9, 0x9}, {0x7d3930, 0x18d5530}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1d88e70 sp=0x1d88e48 pc=0x2f6e68 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Framer).ReadFrame(0x168c680) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1d88eec sp=0x1d88e70 pc=0x2f7600 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2clientConnReadLoop).run(0x1d88fdc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1d88fa4 sp=0x1d88eec pc=0x31be1c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2ClientConn).readLoop(0x14ef708) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1d88fe4 sp=0x1d88fa4 pc=0x31b310 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Transport).newClientConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1d88fec sp=0x1d88fe4 pc=0x31435c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d88fec sp=0x1d88fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*http2Transport).newClientConn in goroutine 12969 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12953 gp=0x1561c28 m=nil [chan receive]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x7366f4, 0x181e630, 0xe, 0x7, 0x2) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x186ad60 sp=0x186ad4c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv(0x181e600, 0x186addb, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x186ad9c sp=0x186ad60 pc=0x1ff80 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.chanrecv1(0x181e600, 0x186addb) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x186adb0 sp=0x186ad9c pc=0x1faa0 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x1850218, 0x14a61e0) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/recv.go:237 +0x1f8 fp=0x186af2c sp=0x186adb0 pc=0x4ea860 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1850218) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:213 +0x4d8 fp=0x186afe4 sp=0x186af2c pc=0x4e8f94 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:125 +0x28 fp=0x186afec sp=0x186afe4 pc=0x4ea5e8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x186afec sp=0x186afec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:125 +0x98 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12952 gp=0x14147e8 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x17bc6b8 sp=0x17bc6a4 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x17bc7d4, 0x17bc77c, 0x0, 0x0, 0x2, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x17bc758 sp=0x17bc6b8 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x16f2798) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:355 +0x8c fp=0x17bc7e4 sp=0x17bc758 pc=0x4859a8 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:264 +0x28 fp=0x17bc7ec sp=0x17bc7e4 pc=0x4850a0 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x17bc7ec sp=0x17bc7ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/ap/ap.go:264 +0x15c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12918 gp=0x147ab48 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046a08, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1868ad4 sp=0x1868ac0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb60469f8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1868aec sp=0x1868ad4 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb60469f8, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1868b00 sp=0x1868aec pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x14a6a68, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1868b14 sp=0x1868b00 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x14a6a50, {0x16c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1868b5c sp=0x1868b14 pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x14a6a50, {0x16c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1868b88 sp=0x1868b5c pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x18da260, {0x16c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1868bb4 sp=0x1868b88 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x18da260, {0x16c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1868bd4 sp=0x1868bb4 pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x140e500, {0x16c2000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1868c00 sp=0x1868bd4 pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x14c060c, {0x7d4554, 0x140e500}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1868c3c sp=0x1868c00 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x14c0488, {0x7d373c, 0x18da260}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1868c64 sp=0x1868c3c pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x14c0488, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1868dc8 sp=0x1868c64 pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x14c0488, {0x16f0000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1868df8 sp=0x1868dc8 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Read(0x1be3620, {0x184e0a4, 0x9, 0x9}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1868e1c sp=0x1868df8 pc=0x2bdf6c Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadAtLeast({0x7d3930, 0x1be3620}, {0x184e0a4, 0x9, 0x9}, 0x9) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1868e48 sp=0x1868e1c pc=0x104280 Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadFull(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:354 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.http2readFrameHeader({0x184e0a4, 0x9, 0x9}, {0x7d3930, 0x1be3620}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1868e70 sp=0x1868e48 pc=0x2f6e68 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Framer).ReadFrame(0x184e080) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1868eec sp=0x1868e70 pc=0x2f7600 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2clientConnReadLoop).run(0x1868fdc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1868fa4 sp=0x1868eec pc=0x31be1c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2ClientConn).readLoop(0x16ee008) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1868fe4 sp=0x1868fa4 pc=0x31b310 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Transport).newClientConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1868fec sp=0x1868fe4 pc=0x31435c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1868fec sp=0x1868fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*http2Transport).newClientConn in goroutine 12917 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 13019 gp=0x147bc28 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb60465a8, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1813afc sp=0x1813ae8 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046598, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1813b14 sp=0x1813afc pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046598, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1813b28 sp=0x1813b14 pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x164e5b8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1813b3c sp=0x1813b28 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x164e5a0, {0x1a9a000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1813b84 sp=0x1813b3c pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x164e5a0, {0x1a9a000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1813bb0 sp=0x1813b84 pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1e940a8, {0x1a9a000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1813bdc sp=0x1813bb0 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1e940a8, {0x1a9a000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1813bfc sp=0x1813bdc pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x14aa4b0, {0x1a9a000, 0xa000, 0xa000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1813c28 sp=0x1813bfc pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x1626a8c, {0x7d4554, 0x14aa4b0}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1813c64 sp=0x1813c28 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x1626908, {0x7d373c, 0x1e940a8}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1813c8c sp=0x1813c64 pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x1626908, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1813df0 sp=0x1813c8c pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x1626908, {0x1db4000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1813e20 sp=0x1813df0 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).Read(0x1850168, {0x1db4000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1977 +0x16c fp=0x1813e54 sp=0x1813e20 pc=0x3550f8 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).fill(0x1be2840) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1813e78 sp=0x1813e54 pc=0x2bd8e0 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Peek(0x1be2840, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:148 +0x68 fp=0x1813e84 sp=0x1813e78 pc=0x2bda64 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).readLoop(0x1850168) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:2141 +0x194 fp=0x1813fe4 sp=0x1813e84 pc=0x355c88 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Transport).dialConn.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1799 +0x28 fp=0x1813fec sp=0x1813fe4 pc=0x3545a8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1813fec sp=0x1813fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Transport).dialConn in goroutine 12977 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1799 +0x13f4 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12954 gp=0x163d0e8 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18ae698 sp=0x18ae684 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x18ae7d4, 0x18ae760, 0x0, 0x0, 0x2, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x18ae738 sp=0x18ae698 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x1850218) Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:138 +0x8c fp=0x18ae7e4 sp=0x18ae738 pc=0x4e868c Jul 06 20:41:32 bladelius go-librespot[6250]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:129 +0x28 fp=0x18ae7ec sp=0x18ae7e4 pc=0x4ea594 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18ae7ec sp=0x18ae7ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 12480 Jul 06 20:41:32 bladelius go-librespot[6250]: /src/dealer/dealer.go:129 +0x15c Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 13020 gp=0x16cc248 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1459eb0 sp=0x1459e9c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x1459fac, 0x1459f78, 0x0, 0x0, 0x2, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1459f50 sp=0x1459eb0 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).writeLoop(0x1850168) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:2444 +0xd0 fp=0x1459fe4 sp=0x1459f50 pc=0x357748 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Transport).dialConn.gowrap3() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1800 +0x28 fp=0x1459fec sp=0x1459fe4 pc=0x354554 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1459fec sp=0x1459fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Transport).dialConn in goroutine 12977 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1800 +0x1444 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12999 gp=0x18c5208 m=nil [select]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736898, 0x0, 0x9, 0x3, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18a36b0 sp=0x18a369c pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.selectgo(0x18a37ac, 0x18a3778, 0x0, 0x0, 0x2, 0x1) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x18a3750 sp=0x18a36b0 pc=0x70d80 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*persistConn).writeLoop(0x14f66e8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:2444 +0xd0 fp=0x18a37e4 sp=0x18a3750 pc=0x357748 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*Transport).dialConn.gowrap3() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1800 +0x28 fp=0x18a37ec sp=0x18a37e4 pc=0x354554 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18a37ec sp=0x18a37ec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*Transport).dialConn in goroutine 12979 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/transport.go:1800 +0x1444 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12645 gp=0x18d26c8 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046968, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d84ad4 sp=0x1d84ac0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046958, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1d84aec sp=0x1d84ad4 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046958, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1d84b00 sp=0x1d84aec pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x186fa58, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1d84b14 sp=0x1d84b00 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x186fa40, {0x18dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1d84b5c sp=0x1d84b14 pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x186fa40, {0x18dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1d84b88 sp=0x1d84b5c pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1490000, {0x18dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1d84bb4 sp=0x1d84b88 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1490000, {0x18dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1d84bd4 sp=0x1d84bb4 pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x177ac20, {0x18dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1d84c00 sp=0x1d84bd4 pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x190c60c, {0x7d4554, 0x177ac20}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1d84c3c sp=0x1d84c00 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x190c488, {0x7d373c, 0x1490000}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1d84c64 sp=0x1d84c3c pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x190c488, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1d84dc8 sp=0x1d84c64 pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x190c488, {0x154e000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1d84df8 sp=0x1d84dc8 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Read(0x1497620, {0x14c47a4, 0x9, 0x9}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1d84e1c sp=0x1d84df8 pc=0x2bdf6c Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadAtLeast({0x7d3930, 0x1497620}, {0x14c47a4, 0x9, 0x9}, 0x9) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1d84e48 sp=0x1d84e1c pc=0x104280 Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadFull(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:354 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.http2readFrameHeader({0x14c47a4, 0x9, 0x9}, {0x7d3930, 0x1497620}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1d84e70 sp=0x1d84e48 pc=0x2f6e68 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Framer).ReadFrame(0x14c4780) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1d84eec sp=0x1d84e70 pc=0x2f7600 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2clientConnReadLoop).run(0x1d84fdc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1d84fa4 sp=0x1d84eec pc=0x31be1c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2ClientConn).readLoop(0x162c108) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1d84fe4 sp=0x1d84fa4 pc=0x31b310 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Transport).newClientConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1d84fec sp=0x1d84fe4 pc=0x31435c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d84fec sp=0x1d84fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*http2Transport).newClientConn in goroutine 12644 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 12934 gp=0x18d2a28 m=nil [IO wait]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gopark(0x736854, 0xb6046b48, 0x2, 0x2, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d82ad4 sp=0x1d82ac0 pc=0x5cfc8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpollblock(0xb6046b38, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1d82aec sp=0x1d82ad4 pc=0x547d4 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.runtime_pollWait(0xb6046b38, 0x72) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1d82b00 sp=0x1d82aec pc=0x8f388 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).wait(0x14a68d8, 0x72, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1d82b14 sp=0x1d82b00 pc=0x10a2d8 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*pollDesc).waitRead(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Jul 06 20:41:32 bladelius go-librespot[6250]: internal/poll.(*FD).Read(0x14a68c0, {0x15dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1d82b5c sp=0x1d82b14 pc=0x10b4c4 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*netFD).Read(0x14a68c0, {0x15dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1d82b88 sp=0x1d82b5c pc=0x17c438 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*conn).Read(0x1da2578, {0x15dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1d82bb4 sp=0x1d82b88 pc=0x18c618 Jul 06 20:41:32 bladelius go-librespot[6250]: net.(*TCPConn).Read(0x1da2578, {0x15dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: :1 +0x44 fp=0x1d82bd4 sp=0x1d82bb4 pc=0x19f86c Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*atLeastReader).Read(0x1604f80, {0x15dc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1d82c00 sp=0x1d82bd4 pc=0x27c1ac Jul 06 20:41:32 bladelius go-librespot[6250]: bytes.(*Buffer).ReadFrom(0x1626f0c, {0x7d4554, 0x1604f80}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1d82c3c sp=0x1d82c00 pc=0x139b90 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readFromUntil(0x1626d88, {0x7d373c, 0x1da2578}, 0x5) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1d82c64 sp=0x1d82c3c pc=0x27c408 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecordOrCCS(0x1626d88, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1d82dc8 sp=0x1d82c64 pc=0x279b08 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).readRecord(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:588 Jul 06 20:41:32 bladelius go-librespot[6250]: crypto/tls.(*Conn).Read(0x1626d88, {0x15fc000, 0x1000, 0x1000}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1d82df8 sp=0x1d82dc8 pc=0x27f978 Jul 06 20:41:32 bladelius go-librespot[6250]: bufio.(*Reader).Read(0x169e5a0, {0x168c5a4, 0x9, 0x9}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1d82e1c sp=0x1d82df8 pc=0x2bdf6c Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadAtLeast({0x7d3930, 0x169e5a0}, {0x168c5a4, 0x9, 0x9}, 0x9) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1d82e48 sp=0x1d82e1c pc=0x104280 Jul 06 20:41:32 bladelius go-librespot[6250]: io.ReadFull(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/io/io.go:354 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.http2readFrameHeader({0x168c5a4, 0x9, 0x9}, {0x7d3930, 0x169e5a0}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1d82e70 sp=0x1d82e48 pc=0x2f6e68 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Framer).ReadFrame(0x168c580) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1d82eec sp=0x1d82e70 pc=0x2f7600 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2clientConnReadLoop).run(0x1d82fdc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1d82fa4 sp=0x1d82eec pc=0x31be1c Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2ClientConn).readLoop(0x14ef608) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1d82fe4 sp=0x1d82fa4 pc=0x31b310 Jul 06 20:41:32 bladelius go-librespot[6250]: net/http.(*http2Transport).newClientConn.gowrap1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1d82fec sp=0x1d82fe4 pc=0x31435c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit({}) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d82fec sp=0x1d82fec pc=0x93c4c Jul 06 20:41:32 bladelius go-librespot[6250]: created by net/http.(*http2Transport).newClientConn in goroutine 12933 Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0xe Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x207 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x20 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x128 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0xb2201ee8 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0xb2201ee8 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0xb2201e58 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0x1610180 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1448b08 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0x145bf84 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x1402a28 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x8 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0xb6eed5b8 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb5efedb0 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0xb6e9e030 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0xb6e9f840 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0x60000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x18 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=0 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0xbcb778 m=0 mp=0xbcc020 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0xbcc0e8, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xbef1fb84 sp=0xbef1fb84 pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0xbcc0e8, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xbef1fbac sp=0xbef1fb84 pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0xbcc0e8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xbef1fbcc sp=0xbef1fbac pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mPark(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1761 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.stopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2782 +0x90 fp=0xbef1fbe0 sp=0xbef1fbcc pc=0x61c34 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.exitsyscall0(0x17de368) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4755 +0x26c fp=0xbef1fc08 sp=0xbef1fbe0 pc=0x67140 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0x7d1dcc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xbef1fc10 sp=0xbef1fc08 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0xbcc0e8 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x17de3b0 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0xbcc020 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0xbcb778 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x16241e3 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xbef1fb84 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c98 m=2 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x14026c8 m=2 mp=0x1448588 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0xbcddac, 0x80, 0x0, 0xb6881d48, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:417 +0x20 fp=0xb6881d28 sp=0xb6881d28 pc=0x94c98 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0xbcddac, 0x0, 0x71242d8a) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:75 +0x178 fp=0xb6881d50 sp=0xb6881d28 pc=0x558a4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notetsleep_internal(0xbcddac, 0x71242d8a) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:212 +0x124 fp=0xb6881d78 sp=0xb6881d50 pc=0x255d4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notetsleep(0xbcddac, 0x71242d8a) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:235 +0x48 fp=0xb6881d8c sp=0xb6881d78 pc=0x25774 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.sysmon() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:6001 +0x2e0 fp=0xb6881de8 sp=0xb6881d8c pc=0x6a720 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1729 +0x7c fp=0xb6881df8 sp=0xb6881de8 pc=0x60064 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart0() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1686 +0x7c fp=0xb6881e0c sp=0xb6881df8 pc=0x5ffd8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:210 +0x8 fp=0xb6881e10 sp=0xb6881e0c pc=0x91f20 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0xfffffffc Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0xb6881d48 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x14026c8 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x3b9aca00 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb6881d28 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x558a4 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c98 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0x60000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x1b52c m=4 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x1402c68 m=4 mp=0x1449088 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime/internal/syscall.Syscall6(0x15a, 0x4, 0xb54fe4e8, 0x80, 0x76c, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/internal/syscall/asm_linux_arm.s:17 +0x20 fp=0xb54fe46c sp=0xb54fe46c pc=0x1b52c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime/internal/syscall.EpollWait(0x4, {0xb54fe4e8, 0x80, 0x80}, 0x80, 0x76c) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/internal/syscall/syscall_linux.go:55 +0x60 fp=0xb54fe49c sp=0xb54fe46c pc=0x1b484 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.netpoll(0x714567ba) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/netpoll_epoll.go:118 +0x17c fp=0xb54fed08 sp=0xb54fe49c pc=0x553c8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.findRunnable() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3470 +0xbbc fp=0xb54fedb4 sp=0xb54fed08 pc=0x6368c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.schedule() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3868 +0xac fp=0xb54fedd0 sp=0xb54fedb4 pc=0x64e24 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.park_m(0x1631688) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4036 +0x1b0 fp=0xb54fedf0 sp=0xb54fedd0 pc=0x6569c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0xb6b35f40) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xb54fedf8 sp=0xb54fedf0 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0xfffffffc Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0xb54fe4e8 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x76c Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0x15a Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0xbcdd20 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x1402c68 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0xb87f64 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x48a36af1 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb54fe46c Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x1b484 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x1b52c Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0x20000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=5 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x1484128 m=5 mp=0x1480008 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0x14800d0, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xb4cfdcc4 sp=0xb4cfdcc4 pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0x14800d0, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xb4cfdcec sp=0xb4cfdcc4 pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0x14800d0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xb4cfdd0c sp=0xb4cfdcec pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mPark(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1761 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.stopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2782 +0x90 fp=0xb4cfdd20 sp=0xb4cfdd0c pc=0x61c34 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.findRunnable() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3512 +0xe04 fp=0xb4cfddcc sp=0xb4cfdd20 pc=0x638d4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.schedule() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3868 +0xac fp=0xb4cfdde8 sp=0xb4cfddcc pc=0x64e24 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.goexit0(0x155f448) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4181 +0x20 fp=0xb4cfddf0 sp=0xb4cfdde8 pc=0x65ce4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0xb5eff900) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xb4cfddf8 sp=0xb4cfddf0 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0x14800d0 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x1410054 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0xbcdd20 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x1484128 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb4cfdcc4 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=6 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x14845a8 m=6 mp=0x1480588 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0xbf67dc, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xb40fed94 sp=0xb40fed94 pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0xbf67dc, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xb40fedbc sp=0xb40fed94 pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0xbf67dc) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xb40feddc sp=0xb40fedbc pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.templateThread() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2760 +0x90 fp=0xb40fede8 sp=0xb40feddc pc=0x61aec Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart1() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1729 +0x7c fp=0xb40fedf8 sp=0xb40fede8 pc=0x60064 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart0() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1686 +0x7c fp=0xb40fee0c sp=0xb40fedf8 pc=0x5ffd8 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mstart() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:210 +0x8 fp=0xb40fee10 sp=0xb40fee0c pc=0x91f20 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0xbf67dc Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0xbef1fa3a Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0xb40ff440 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x14845a8 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0xb3700470 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb40fed94 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=7 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x1403b08 m=7 mp=0x1449608 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0x14496d0, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xb36fec94 sp=0xb36fec94 pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0x14496d0, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xb36fecbc sp=0xb36fec94 pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0x14496d0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xb36fecdc sp=0xb36fecbc pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mPark(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1761 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.stopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2782 +0x90 fp=0xb36fecf0 sp=0xb36fecdc pc=0x61c34 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.gcstopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3081 +0xd4 fp=0xb36fed08 sp=0xb36fecf0 pc=0x628ec Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.findRunnable() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3149 +0x48 fp=0xb36fedb4 sp=0xb36fed08 pc=0x62b18 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.schedule() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3868 +0xac fp=0xb36fedd0 sp=0xb36fedb4 pc=0x64e24 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.park_m(0x15610e8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4036 +0x1b0 fp=0xb36fedf0 sp=0xb36fedd0 pc=0x6569c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0xb5eff900) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xb36fedf8 sp=0xb36fedf0 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0x14496d0 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0xbcdd20 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x1403b08 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x48b17c7d Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb36fec94 Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=8 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x155ea28 m=8 mp=0x144a108 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0x144a1d0, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xb2cfecac sp=0xb2cfecac pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0x144a1d0, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xb2cfecd4 sp=0xb2cfecac pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0x144a1d0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xb2cfecf4 sp=0xb2cfecd4 pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mPark(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1761 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.stopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2782 +0x90 fp=0xb2cfed08 sp=0xb2cfecf4 pc=0x61c34 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.findRunnable() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3512 +0xe04 fp=0xb2cfedb4 sp=0xb2cfed08 pc=0x638d4 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.schedule() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:3868 +0xac fp=0xb2cfedd0 sp=0xb2cfedb4 pc=0x64e24 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.park_m(0x17e5c28) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4036 +0x1b0 fp=0xb2cfedf0 sp=0xb2cfedd0 pc=0x6569c Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0xb5eff900) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xb2cfedf8 sp=0xb2cfedf0 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0x144a1d0 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0xbcdd20 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x155ea28 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0x6edb797 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb2cfecac Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: ----- Jul 06 20:41:32 bladelius go-librespot[6250]: SIGQUIT: quit Jul 06 20:41:32 bladelius go-librespot[6250]: PC=0x94c94 m=9 sigcode=0 Jul 06 20:41:32 bladelius go-librespot[6250]: goroutine 0 gp=0x15d50e8 m=9 mp=0x1481b88 [idle]: Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futex(0x1481c50, 0x80, 0x0, 0x0, 0x0, 0x0) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/sys_linux_arm.s:416 +0x1c fp=0xb201fd6c sp=0xb201fd6c pc=0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.futexsleep(0x1481c50, 0x0, 0xffffffffffffffff) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/os_linux.go:69 +0x5c fp=0xb201fd94 sp=0xb201fd6c pc=0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.notesleep(0x1481c50) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/lock_futex.go:170 +0xb8 fp=0xb201fdb4 sp=0xb201fd94 pc=0x25450 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mPark(...) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:1761 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.stopm() Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:2782 +0x90 fp=0xb201fdc8 sp=0xb201fdb4 pc=0x61c34 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.exitsyscall0(0x19138c8) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/proc.go:4755 +0x26c fp=0xb201fdf0 sp=0xb201fdc8 pc=0x67140 Jul 06 20:41:32 bladelius go-librespot[6250]: runtime.mcall(0xb2cff900) Jul 06 20:41:32 bladelius go-librespot[6250]: /usr/local/go/src/runtime/asm_arm.s:265 +0x48 fp=0xb201fdf8 sp=0xb201fdf0 pc=0x91f80 Jul 06 20:41:32 bladelius go-librespot[6250]: trap 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: error 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: oldmask 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r0 0x1481c50 Jul 06 20:41:32 bladelius go-librespot[6250]: r1 0x80 Jul 06 20:41:32 bladelius go-librespot[6250]: r2 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r3 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r4 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r5 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r6 0x1913910 Jul 06 20:41:32 bladelius go-librespot[6250]: r7 0xf0 Jul 06 20:41:32 bladelius go-librespot[6250]: r8 0x1481b88 Jul 06 20:41:32 bladelius go-librespot[6250]: r9 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: r10 0x15d50e8 Jul 06 20:41:32 bladelius go-librespot[6250]: fp 0x6 Jul 06 20:41:32 bladelius go-librespot[6250]: ip 0xb413a548 Jul 06 20:41:32 bladelius go-librespot[6250]: sp 0xb201fd6c Jul 06 20:41:32 bladelius go-librespot[6250]: lr 0x55788 Jul 06 20:41:32 bladelius go-librespot[6250]: pc 0x94c94 Jul 06 20:41:32 bladelius go-librespot[6250]: cpsr 0xa0000010 Jul 06 20:41:32 bladelius go-librespot[6250]: fault 0x0 Jul 06 20:41:32 bladelius go-librespot[6250]: Aborted Jul 06 20:41:32 bladelius systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Jul 06 20:41:32 bladelius systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jul 06 20:41:32 bladelius volumio[974]: info: Connection to go-librespot Websocket closed Jul 06 20:41:32 bladelius volumio[974]: info: Connection to go-librespot Websocket closed Jul 06 20:41:32 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:33 bladelius bladelius[697]: Displaying Popup timeout, popup flag: 1751827294 - 1751827290 Jul 06 20:41:33 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:34 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:35 bladelius volumio[974]: info: Initializing connection to go-librespot Websocket Jul 06 20:41:35 bladelius volumio[974]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Jul 06 20:41:35 bladelius systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jul 06 20:41:35 bladelius systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Jul 06 20:41:35 bladelius systemd[1]: Stopped go-librespot Daemon. Jul 06 20:41:35 bladelius systemd[1]: Started go-librespot Daemon. Jul 06 20:41:35 bladelius go-librespot[30431]: go-librespot daemon starting... Jul 06 20:41:35 bladelius go-librespot[30431]: time="2025-07-06T20:41:35+02:00" level=info msg="running go-librespot 0.2.0" Jul 06 20:41:35 bladelius go-librespot[30431]: time="2025-07-06T20:41:35+02:00" level=debug msg="app state loaded" Jul 06 20:41:35 bladelius go-librespot[30431]: time="2025-07-06T20:41:35+02:00" level=info msg="api server listening on 127.0.0.1:9879" Jul 06 20:41:35 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=info msg="zeroconf server listening on port 41163" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="obtained new client token: AAAvLJOK2uTMpq5TsEfenEtfbA0waYmjLZcRcG4v1zy/jTg/jyk+pq2zzueGzipDba2GelI5Evshh6EHaW6CygoTNlYuoiHr9l1dRrbo2WPWK6VOc0zAqFKDvK6+/ThXvYknIqgOgvQEp4GKHg7fmjE1uaJwIw71EFVweqem3NP/TY+VWiqNFQ2q2+3L8SMvzz/+9KGdGGEkPUrM4FahSvzLC1b36HLQMdykw4vAhg/6fOv/w38PTxg=" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="completed keyexchange" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="completed challenge" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=info msg="authenticated AP as frode.alfei" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=info msg="authenticated Login5 as frode.alfei" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="initializing zeroconf session, username: frode.alfei" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="dealer connection opened" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=trace msg="starting accesspoint recv loop" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=trace msg="starting dealer recv loop" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=trace msg="received accesspoint ping" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="received connection id: YzQxM2UxMTctM2NhZC00YmUzLWEzMjMtMjQ5ZDYyNGE1YTE1K2RlYWxlcit0Y3A6Ly8wYWIxNTIwYy5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArNjlGNjJCNjI2MjgzMDA5QjU4NTQ2QzAxRjJEQzlENDE3OTFGMURENzNEMkFBMTdBNDMwQUJGRjA3M0NGMUFBNg==" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=trace msg="received accesspoint pong ack" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="put connect state because NEW_DEVICE" Jul 06 20:41:36 bladelius go-librespot[30431]: time="2025-07-06T20:41:36+02:00" level=debug msg="update volume to 65535/65535" Jul 06 20:41:36 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:37 bladelius go-librespot[30431]: time="2025-07-06T20:41:37+02:00" level=debug msg="put connect state because VOLUME_CHANGED" Jul 06 20:41:37 bladelius go-librespot[30431]: time="2025-07-06T20:41:37+02:00" level=trace msg="emitting websocket event: volume" Jul 06 20:41:37 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:38 bladelius volumio[974]: info: Initializing connection to go-librespot Websocket Jul 06 20:41:38 bladelius go-librespot[30431]: time="2025-07-06T20:41:38+02:00" level=debug msg="new websocket client" Jul 06 20:41:38 bladelius volumio[974]: info: Connection to go-librespot Websocket established Jul 06 20:41:38 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:39 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 20:41:40 bladelius volumio[974]: info: Discovery: Getting this device information Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 20:41:40 bladelius volumio[974]: verbose: New Socket.io Connection to 192.168.1.165:3000 from 192.168.1.72 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 06 20:41:40 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:41 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:41 bladelius volumio[974]: info: Getting Spotify volume Jul 06 20:41:41 bladelius volumio[974]: info: Spotify volume: 100 Jul 06 20:41:41 bladelius volumio[974]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jul 06 20:41:41 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:41 bladelius sudo[30467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 20:41:41 bladelius sudo[30467]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 20:41:42 bladelius sudo[30467]: pam_unix(sudo:session): session closed for user root Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:42 bladelius sudo[30470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 20:41:42 bladelius sudo[30470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 20:41:42 bladelius sudo[30470]: pam_unix(sudo:session): session closed for user root Jul 06 20:41:42 bladelius volumio[974]: verbose: New Socket.io Connection to 192.168.1.165 from 192.168.1.72 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::volumioGetVisibleSources Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 06 20:41:42 bladelius volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 20:41:42 bladelius sudo[30475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 06 20:41:42 bladelius sudo[30475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 20:41:42 bladelius sudo[30475]: pam_unix(sudo:session): session closed for user root Jul 06 20:41:42 bladelius sudo[30478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 06 20:41:42 bladelius sudo[30478]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 06 20:41:42 bladelius sudo[30478]: pam_unix(sudo:session): session closed for user root Jul 06 20:41:42 bladelius volumio[974]: verbose: New Socket.io Connection to 192.168.1.165 from 192.168.1.72 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 06 20:41:42 bladelius volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 06 20:41:42 bladelius volumio[974]: info: Listing playlists Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 20:41:42 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:43 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:44 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:45 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 20:41:45 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 20:41:45 bladelius volumio[974]: info: Discovery: Getting this device information Jul 06 20:41:45 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:45 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 20:41:45 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:46 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:47 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:48 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:49 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:50 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:51 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:52 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:53 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:54 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:55 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:57 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:58 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:41:59 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 06 20:42:00 bladelius volumio[974]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 06 20:42:00 bladelius volumio[974]: info: Received Get System Version Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 06 20:42:00 bladelius volumio[974]: info: Received Get System Info Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 20:42:00 bladelius volumio[974]: info: Discovery: Getting this device information Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:00 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 20:42:01 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:02 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:03 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:04 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:05 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:06 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:06 bladelius go-librespot[30431]: time="2025-07-06T20:42:06+02:00" level=trace msg="sent dealer ping" Jul 06 20:42:06 bladelius go-librespot[30431]: time="2025-07-06T20:42:06+02:00" level=trace msg="received dealer pong" Jul 06 20:42:07 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:08 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:09 bladelius volumio[974]: verbose: New Socket.io Connection to 192.168.1.165 from 192.168.1.72 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 06 20:42:09 bladelius volumio[974]: info: Discovery: Getting this device information Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:09 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 06 20:42:09 bladelius volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 06 20:42:09 bladelius volumio[974]: info: Listing playlists Jul 06 20:42:10 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:11 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:12 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:13 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:14 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:14 bladelius volumio[974]: info: VolumeController::SetAlsaVolume105 Jul 06 20:42:14 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:14 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 20:42:14 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:14 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:14 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:15 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:15 bladelius volumio[974]: info: VolumeController::SetAlsaVolume110 Jul 06 20:42:15 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:15 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 20:42:15 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:15 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:15 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:16 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:16 bladelius volumio[974]: info: VolumeController::SetAlsaVolume109 Jul 06 20:42:16 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:16 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 20:42:16 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:16 bladelius volumio[974]: info: VolumeController::SetAlsaVolume115 Jul 06 20:42:16 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:16 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:16 bladelius volumio[974]: info: VolumeController::SetAlsaVolume109 Jul 06 20:42:16 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:16 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:16 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:17 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:17 bladelius volumio[974]: info: VolumeController::SetAlsaVolume105 Jul 06 20:42:17 bladelius volumio[974]: info: CoreStateMachine::pushState Jul 06 20:42:17 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 06 20:42:17 bladelius volumio[974]: info: CoreCommandRouter::volumioPushState Jul 06 20:42:17 bladelius volumio[974]: info: MRS: Pushing multiroomSync output update for this device Jul 06 20:42:17 bladelius volumio[974]: info: MRS: Pushing multiroomSync output Jul 06 20:42:18 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:19 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:20 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:21 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:22 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:23 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:24 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:24 bladelius volumio[974]: info: CoreCommandRouter::volumioRandom Jul 06 20:42:24 bladelius volumio[974]: info: CoreCommandRouter::writePlayerControls Jul 06 20:42:24 bladelius volumio[974]: info: CoreStateMachine::setRepeat true single false Jul 06 20:42:24 bladelius volumio[974]: info: WARNING: No repeat method for plugin bluetooth Jul 06 20:42:25 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:26 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:27 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:28 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:29 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:30 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:31 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:32 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:33 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:34 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:35 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:36 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:36 bladelius go-librespot[30431]: time="2025-07-06T20:42:36+02:00" level=trace msg="sent dealer ping" Jul 06 20:42:36 bladelius go-librespot[30431]: time="2025-07-06T20:42:36+02:00" level=trace msg="received dealer pong" Jul 06 20:42:37 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:38 bladelius volumio[974]: info: CoreCommandRouter::volumioGetState Jul 06 20:42:38 bladelius volumio[974]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Jul 06 20:42:38 bladelius volumio[974]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Jul 06 20:42:38 bladelius volumio[974]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 20:42:38 bladelius volumio[974]: TypeError: Cannot read property 'then' of undefined Jul 06 20:42:38 bladelius volumio[974]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Jul 06 20:42:38 bladelius volumio[974]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Jul 06 20:42:38 bladelius volumio[974]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) Jul 06 20:42:38 bladelius volumio[974]: at Socket.emit (events.js:315:20) Jul 06 20:42:38 bladelius volumio[974]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jul 06 20:42:38 bladelius volumio[974]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 06 20:42:38 bladelius volumio[974]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 06 20:42:39 bladelius sudo[30759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-06 20:41 Jul 06 20:42:39 bladelius sudo[30759]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="bladelius" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 08 Apr 2025 10:47:12 AM CEST" VOLUMIO_VERSION="3.796" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4f9f9b69f9639accc223c220a6301101"