Dec 29 04:47:02 stereo go-librespot[1420]: time="2025-12-29T04:47:02+01:00" level=trace msg="received accesspoint ping" Dec 29 04:47:02 stereo go-librespot[1420]: time="2025-12-29T04:47:02+01:00" level=trace msg="received accesspoint pong ack" Dec 29 04:47:02 stereo go-librespot[1420]: time="2025-12-29T04:47:02+01:00" level=trace msg="sent dealer ping" Dec 29 04:47:02 stereo go-librespot[1420]: time="2025-12-29T04:47:02+01:00" level=trace msg="received dealer pong" Dec 29 04:47:30 stereo volumio[1152]: info: CoreCommandRouter::volumioGetState Dec 29 04:47:32 stereo go-librespot[1420]: time="2025-12-29T04:47:32+01:00" level=trace msg="sent dealer ping" Dec 29 04:47:32 stereo go-librespot[1420]: time="2025-12-29T04:47:32+01:00" level=trace msg="received dealer pong" Dec 29 04:47:35 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 29 04:47:35 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 29 04:47:39 stereo volumio[1152]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 29 04:47:48 stereo volumio[1152]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Dec 29 04:47:48 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Dec 29 04:47:48 stereo volumio[1152]: info: Creating Spotify config file Dec 29 04:47:48 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 04:47:48 stereo volumio[1152]: info: Spotify config file written Dec 29 04:47:48 stereo sudo[5881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 29 04:47:48 stereo sudo[5881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 04:47:48 stereo systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 29 04:47:48 stereo systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 29 04:47:48 stereo systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 29 04:47:48 stereo systemd[1]: go-librespot-daemon.service: Consumed 18.224s CPU time. Dec 29 04:47:48 stereo volumio[1152]: info: Connection to go-librespot Websocket closed Dec 29 04:47:48 stereo systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 29 04:47:48 stereo sudo[5881]: pam_unix(sudo:session): session closed for user root Dec 29 04:47:48 stereo go-librespot[5884]: go-librespot daemon starting... Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=info msg="running go-librespot 0.4.0" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="app state loaded" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=info msg="zeroconf server listening on port 43237" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="obtained new client token: AABt7tNjFnV1gpiUCDLpKfasF2/isotH0PCuWIsCOEkBaOUNFUqc1/A3uW2APF7gNCpCMK5Y2nFkKfe4MrDmWzD/y6TlFhGUk6reqwQw3I8s6S0y7rOk8jDP4bEXg4sTpcX45HhkfaKscGemhkglPlBlI2XX/60yyITPmPoYQtk8sQIi0BTRRgBJ/ldP6fUOpPeWBRI0bsJkrUFT3wYXZTLuZ9cWF9QtylFnMA2OHsPtAnDMkdxFDXgAMQ==" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="completed keyexchange" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="completed challenge" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=info msg="authenticated AP" username="82*********************mg" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=info msg="authenticated Login5" username="82*********************mg" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="initializing zeroconf session" username="82*********************mg" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="dealer connection opened" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=trace msg="starting accesspoint recv loop" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=trace msg="starting dealer recv loop" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=trace msg="received accesspoint ping" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=debug msg="received connection id: ODFkMjIzNDgtZWYx...NjEwMUY3RDNCOQ==" Dec 29 04:47:48 stereo go-librespot[5885]: time="2025-12-29T04:47:48+01:00" level=trace msg="received accesspoint pong ack" Dec 29 04:47:49 stereo go-librespot[5885]: time="2025-12-29T04:47:49+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 29 04:47:51 stereo volumio[1152]: info: Initializing connection to go-librespot Websocket Dec 29 04:47:51 stereo go-librespot[5885]: time="2025-12-29T04:47:51+01:00" level=debug msg="new websocket client" Dec 29 04:47:51 stereo volumio[1152]: info: Connection to go-librespot Websocket established Dec 29 04:47:51 stereo volumio[1152]: info: go-librespot daemon successfully initialized Dec 29 04:47:54 stereo volumio[1152]: info: Getting Spotify volume Dec 29 04:47:54 stereo volumio[1152]: info: Spotify volume: 100 Dec 29 04:47:54 stereo volumio[1152]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 29 04:47:54 stereo volumio[1152]: info: CoreCommandRouter::volumioGetState Dec 29 04:47:54 stereo volumio[1152]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Dec 29 04:47:54 stereo volumio[1152]: SPOTIFY: SPOTIFY VOLUME 100 Dec 29 04:47:54 stereo volumio[1152]: SPOTIFY: VOLUMIO VOLUME 5 Dec 29 04:47:54 stereo volumio[1152]: SPOTIFY: DELTA VOLUME ENOUGH: true Dec 29 04:47:54 stereo volumio[1152]: info: Setting Spotify Volume from Volumio: 5 Dec 29 04:47:54 stereo volumio[1152]: info: Initializing connection to go-librespot Websocket Dec 29 04:47:54 stereo go-librespot[5885]: time="2025-12-29T04:47:54+01:00" level=debug msg="new websocket client" Dec 29 04:47:54 stereo volumio[1152]: info: Connection to go-librespot Websocket established Dec 29 04:47:55 stereo volumio[1152]: SPOTIFY: SETTING SPOTIFY VOLUME 5 Dec 29 04:47:55 stereo volumio[1152]: info: Sending Spotify command with payload to local API: /player/volume Dec 29 04:47:55 stereo go-librespot[5885]: time="2025-12-29T04:47:55+01:00" level=debug msg="update volume requested to 3276/65535" Dec 29 04:47:55 stereo go-librespot[5885]: time="2025-12-29T04:47:55+01:00" level=debug msg="put connect state because VOLUME_CHANGED" Dec 29 04:47:55 stereo go-librespot[5885]: time="2025-12-29T04:47:55+01:00" level=trace msg="emitting websocket event: volume" Dec 29 04:47:56 stereo volumio[1152]: SPOTIFY: received: {"type":"volume","data":{"value":5,"max":100}} Dec 29 04:47:56 stereo volumio[1152]: SPOTIFY: RECEIVED SPOTIFY VOLUME 5 Dec 29 04:47:56 stereo volumio[1152]: SPOTIFY: received: {"type":"volume","data":{"value":5,"max":100}} Dec 29 04:47:56 stereo volumio[1152]: SPOTIFY: RECEIVED SPOTIFY VOLUME 5 Dec 29 04:47:57 stereo volumio[1152]: info: Getting Spotify volume Dec 29 04:47:57 stereo volumio[1152]: info: Spotify volume: 5 Dec 29 04:47:57 stereo volumio[1152]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 29 04:47:57 stereo volumio[1152]: info: CoreCommandRouter::volumioGetState Dec 29 04:47:57 stereo volumio[1152]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Dec 29 04:48:03 stereo ntpd[901]: PROTO: 129.250.35.250 unlink local addr 192.168.1.191 -> Dec 29 04:48:18 stereo go-librespot[5885]: time="2025-12-29T04:48:18+01:00" level=trace msg="sent dealer ping" Dec 29 04:48:18 stereo go-librespot[5885]: time="2025-12-29T04:48:18+01:00" level=trace msg="received dealer pong" Dec 29 04:48:26 stereo volumio[1152]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Dec 29 04:48:26 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Dec 29 04:48:26 stereo volumio[1152]: info: Creating Spotify config file Dec 29 04:48:26 stereo volumio[1152]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 04:48:26 stereo volumio[1152]: info: Spotify config file written Dec 29 04:48:26 stereo sudo[5959]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 29 04:48:26 stereo sudo[5959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 29 04:48:26 stereo systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Dec 29 04:48:26 stereo volumio[1152]: info: Connection to go-librespot Websocket closed Dec 29 04:48:26 stereo systemd[1]: go-librespot-daemon.service: Killing process 5891 (go-librespot) with signal SIGKILL. Dec 29 04:48:26 stereo volumio[1152]: info: Connection to go-librespot Websocket closed Dec 29 04:48:26 stereo systemd[1]: go-librespot-daemon.service: Deactivated successfully. Dec 29 04:48:26 stereo systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 29 04:48:26 stereo systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 29 04:48:26 stereo go-librespot[5961]: go-librespot daemon starting... Dec 29 04:48:26 stereo sudo[5959]: pam_unix(sudo:session): session closed for user root Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=info msg="running go-librespot 0.4.0" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="app state loaded" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=info msg="zeroconf server listening on port 44943" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="obtained new client token: AADWj6nD7wBOL+Nec0sd0i4XwBlRHNqlPOA7fsmhrJG0hmFuVH02LHyaxZEutdVqmul+UF4RP2BHjgVE58DbZMRDT+laaIC7WKCW0724xQciCuF5nJa0eD25VGPb5bmoAwx4CyueEwy5Fv5VKMPH0g5pO4Ii4eI54pvB10Q7HItbkdymBtt6KhKo6618zJ/IISRnSldvEUCmmu4vU7RM/L+tX12W4QUPlkYe+CC3wnUdKHErl0dhv5KM7Q==" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="completed keyexchange" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="completed challenge" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=info msg="authenticated AP" username="82*********************mg" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=info msg="authenticated Login5" username="82*********************mg" Dec 29 04:48:26 stereo go-librespot[5962]: time="2025-12-29T04:48:26+01:00" level=debug msg="initializing zeroconf session" username="82*********************mg" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="dealer connection opened" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=trace msg="starting accesspoint recv loop" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=trace msg="starting dealer recv loop" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=trace msg="received accesspoint ping" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="received connection id: YmI3NzVkNmItOTE5...NDA0OTIwRTY0Qg==" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=trace msg="received accesspoint pong ack" Dec 29 04:48:27 stereo go-librespot[5962]: time="2025-12-29T04:48:27+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 29 04:48:27 stereo volumio[1152]: info: CoreCommandRouter::volumioPause Dec 29 04:48:27 stereo volumio[1152]: info: CoreStateMachine::pause Dec 29 04:48:29 stereo volumio[1152]: info: Initializing connection to go-librespot Websocket Dec 29 04:48:29 stereo go-librespot[5962]: time="2025-12-29T04:48:29+01:00" level=debug msg="new websocket client" Dec 29 04:48:29 stereo volumio[1152]: info: Connection to go-librespot Websocket established Dec 29 04:48:29 stereo volumio[1152]: info: CoreCommandRouter::volumioPause Dec 29 04:48:29 stereo volumio[1152]: info: CoreStateMachine::pause Dec 29 04:48:29 stereo volumio[1152]: info: go-librespot daemon successfully initialized Dec 29 04:48:30 stereo volumio[1152]: info: CoreCommandRouter::volumioPrevious Dec 29 04:48:30 stereo volumio[1152]: info: Spotify previous Dec 29 04:48:30 stereo volumio[1152]: info: Sending Spotify command to local API: /player/prev Dec 29 04:48:30 stereo go-librespot[5962]: panic: runtime error: invalid memory address or nil pointer dereference Dec 29 04:48:30 stereo go-librespot[5962]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x4 pc=0x6372e0] Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 31 gp=0x17d7208 m=5 mp=0x1480008 [running]: Dec 29 04:48:30 stereo go-librespot[5962]: panic({0x6cfb00, 0xca02c0}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x184b46c sp=0x184b418 pc=0x58bf8 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.panicmem(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/panic.go:261 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.sigpanic() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/signal_unix.go:881 +0x39c fp=0x184b49c sp=0x184b46c pc=0x74be4 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*AppPlayer).loadCurrentTrack(0x1899cc0, {0x8874f0, 0xd0ad00}, 0x0, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/controls.go:255 +0x144 fp=0x184b6cc sp=0x184b4a0 pc=0x6372e0 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*AppPlayer).skipPrev(0x1899cc0, {0x8874f0, 0xd0ad00}, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/controls.go:516 +0x4b0 fp=0x184b754 sp=0x184b6cc pc=0x63a36c Dec 29 04:48:30 stereo go-librespot[5962]: main.(*AppPlayer).handleApiRequest(0x1899cc0, {0x8874f0, 0xd0ad00}, {{0x791342, 0x4}, {0x0, 0x0}, 0x152e0c0}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/player.go:471 +0x7c0 fp=0x184b8e4 sp=0x184b754 pc=0x643ea4 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*AppPlayer).Run(0x1899cc0, {0x8874f0, 0xd0ad00}, 0x147df40) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/player.go:610 +0x864 fp=0x184bfd8 sp=0x184b8e4 pc=0x645db0 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).withAppPlayer.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:258 +0x40 fp=0x184bfec sp=0x184bfd8 pc=0x63e874 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x184bfec sp=0x184bfec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by main.(*App).withAppPlayer in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:258 +0x3d8 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 1 gp=0x1402128 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x145ad00 sp=0x145acec pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x145ae00, 0x1609dcc, 0x0, 0x0, 0x2, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x145ada0 sp=0x145ad00 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x18dd1a0, 0x145ae90) Dec 29 04:48:30 stereo go-librespot[5962]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x145ae44 sp=0x145ada0 pc=0x5a8088 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).withAppPlayer(0x154cc00, {0x8874f0, 0xd0ad00}, 0x1527520) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:321 +0x554 fp=0x145aed0 sp=0x145ae44 pc=0x63db54 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).withCredentials(...) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:193 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).SpotifyToken(0x154cc00, {0x8874f0, 0xd0ad00}, {0x154a8c0, 0x19}, {0x15203c0, 0x138}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:185 +0xd8 fp=0x145af00 sp=0x145aed0 pc=0x63cfa8 Dec 29 04:48:30 stereo go-librespot[5962]: main.main() Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:557 +0x588 fp=0x145afa8 sp=0x145af00 pc=0x63feb4 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.main() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x145afec sp=0x145afa8 pc=0x5cb30 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x145afec sp=0x145afec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 2 gp=0x14027e8 m=nil [force gc (idle)]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1444fd4 sp=0x1444fc0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goparkunlock(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:408 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.forcegchelper() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1444fec sp=0x1444fd4 pc=0x5cefc Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1444fec sp=0x1444fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.init.5 in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:314 +0x1c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 18 gp=0x1484248 m=nil [GC sweep wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14407c4 sp=0x14407b0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goparkunlock(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:408 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.bgsweep(0x1490000) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x14407e4 sp=0x14407c4 pc=0x45848 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcenable.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x14407ec sp=0x14407e4 pc=0x35968 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14407ec sp=0x14407ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcenable in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 19 gp=0x1484368 m=nil [GC scavenge wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1440fb4 sp=0x1440fa0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goparkunlock(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:408 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.(*scavengerState).park(0xce0208) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1440fc8 sp=0x1440fb4 pc=0x42b68 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.bgscavenge(0x1490000) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1440fe4 sp=0x1440fc8 pc=0x432a0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcenable.gowrap2() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1440fec sp=0x1440fe4 pc=0x35914 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1440fec sp=0x1440fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcenable in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 34 gp=0x1504488 m=nil [finalizer wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x153478c sp=0x1534778 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.runfinq() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x15347ec sp=0x153478c pc=0x34754 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15347ec sp=0x15347ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.createfing in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 37 gp=0x1505b08 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7ec8, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1866d28 sp=0x1866d14 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7eb8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1866d40 sp=0x1866d28 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7eb8, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1866d54 sp=0x1866d40 pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1523468, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1866d68 sp=0x1866d54 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Accept(0x1523450) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1866db0 sp=0x1866d68 pc=0x10eb84 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).accept(0x1523450) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1866e18 sp=0x1866db0 pc=0x17e4c4 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPListener).accept(0x1538810) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1866e30 sp=0x1866e18 pc=0x196900 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPListener).Accept(0x1538810) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1866e4c sp=0x1866e30 pc=0x19596c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*onceCloseListener).Accept(0x147e340) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x34 fp=0x1866e64 sp=0x1866e4c pc=0x362b54 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*Server).Serve(0x14780a8, {0x886cb8, 0x1538810}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1866efc sp=0x1866e64 pc=0x341210 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.Serve(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2794 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).serve(0x1528fc0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x1866fe4 sp=0x1866efc pc=0x6330b8 Dec 29 04:48:30 stereo go-librespot[5962]: main.NewApiServer.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x1866fec sp=0x1866fe4 pc=0x631de4 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1866fec sp=0x1866fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by main.NewApiServer in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:296 +0x310 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 3 gp=0x1505c28 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7ce8, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1778e84 sp=0x1778e70 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7cd8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1778e9c sp=0x1778e84 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7cd8, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1778eb0 sp=0x1778e9c pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1899c38, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1778ec4 sp=0x1778eb0 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).RawRead(0x1899c20, 0x14f4cc0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1778ef0 sp=0x1778ec4 pc=0x10f788 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*rawConn).Read(0x1431478, 0x14f4cc0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1778f10 sp=0x1778ef0 pc=0x190d28 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x140fb80, 0x14f4c90, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1778f40 sp=0x1778f10 pc=0x548824 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x14982a8, {0x16e2000, 0x10000, 0x10000}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x1778f9c sp=0x1778f40 pc=0x54c80c Dec 29 04:48:30 stereo go-librespot[5962]: github.com/grandcat/zeroconf.(*Server).recv4(0x1682fc0, 0x14982a0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1778fe0 sp=0x1778f9c pc=0x5a309c Dec 29 04:48:30 stereo go-librespot[5962]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1778fec sp=0x1778fe0 pc=0x5a2d54 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1778fec sp=0x1778fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 20 Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 114 gp=0x1505d48 m=nil [chan receive]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3f90, 0x152e0f0, 0xe, 0x7, 0x2) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1862bcc sp=0x1862bb8 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv(0x152e0c0, 0x1862c98, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1862c08 sp=0x1862bcc pc=0x20078 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv1(0x152e0c0, 0x1862c98) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x1862c1c sp=0x1862c08 pc=0x1fb98 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).handleRequest(0x1528fc0, {{0x791342, 0x4}, {0x0, 0x0}, 0x152e0c0}, {0x886dec, 0x18d60a8}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:319 +0x74 fp=0x1862ca8 sp=0x1862c1c pc=0x631f94 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).serve.func9({0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:458 +0x9c fp=0x1862ccc sp=0x1862ca8 pc=0x634684 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.HandlerFunc.ServeHTTP(0x14300d0, {0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1862cdc sp=0x1862ccc pc=0x33d7f4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*ServeMux).ServeHTTP(0x1474000, {0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1862d18 sp=0x1862cdc pc=0x33f654 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1862d40 sp=0x1862d18 pc=0x633388 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.HandlerFunc.ServeHTTP(0x140e190, {0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1862d50 sp=0x1862d40 pc=0x33d7f4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.serverHandler.ServeHTTP({0x14780a8}, {0x886dec, 0x18d60a8}, 0x18d6008) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1862d6c sp=0x1862d50 pc=0x340de4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*conn).serve(0x168a000, {0x887510, 0x1426198}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1862fdc sp=0x1862d6c pc=0x33c034 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*Server).Serve.gowrap3() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1862fec sp=0x1862fdc pc=0x341688 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1862fec sp=0x1862fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*Server).Serve in goroutine 37 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3285 +0x468 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 48 gp=0x1505e68 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7e28, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x145bad4 sp=0x145bac0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7e18, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x145baec sp=0x145bad4 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7e18, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x145bb00 sp=0x145baec pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x15235f8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x145bb14 sp=0x145bb00 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x15235e0, {0x1597000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x145bb5c sp=0x145bb14 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x15235e0, {0x1597000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x145bb88 sp=0x145bb5c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x1706000, {0x1597000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x145bbb4 sp=0x145bb88 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x1706000, {0x1597000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x145bbd4 sp=0x145bbb4 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*atLeastReader).Read(0x170c1e0, {0x1597000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x145bc00 sp=0x145bbd4 pc=0x27c680 Dec 29 04:48:30 stereo go-librespot[5962]: bytes.(*Buffer).ReadFrom(0x170a18c, {0x883674, 0x170c1e0}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x145bc3c sp=0x145bc00 pc=0x139bd0 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readFromUntil(0x170a008, {0x882848, 0x1706000}, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x145bc64 sp=0x145bc3c pc=0x27c8dc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecordOrCCS(0x170a008, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x145bdc8 sp=0x145bc64 pc=0x279fdc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecord(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).Read(0x170a008, {0x1647000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x145bdf8 sp=0x145bdc8 pc=0x27fe4c Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).Read(0x189dc20, {0x1474124, 0x9, 0x9}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x145be1c sp=0x145bdf8 pc=0x2be440 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadAtLeast({0x882a3c, 0x189dc20}, {0x1474124, 0x9, 0x9}, 0x9) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x145be48 sp=0x145be1c pc=0x1042c0 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadFull(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:354 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.http2readFrameHeader({0x1474124, 0x9, 0x9}, {0x882a3c, 0x189dc20}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x145be70 sp=0x145be48 pc=0x2f733c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Framer).ReadFrame(0x1474100) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x145beec sp=0x145be70 pc=0x2f7ad4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2clientConnReadLoop).run(0x145bfdc) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x145bfa4 sp=0x145beec pc=0x31c2f0 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2ClientConn).readLoop(0x1579d08) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x145bfe4 sp=0x145bfa4 pc=0x31b7e4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x145bfec sp=0x145bfe4 pc=0x314830 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x145bfec sp=0x145bfec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*http2Transport).newClientConn in goroutine 47 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 43 gp=0x17d6128 m=nil [GC worker (idle)]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3fbc, 0x189e5d0, 0x1a, 0xa, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1535790 sp=0x153577c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcBgMarkWorker() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x15357ec sp=0x1535790 pc=0x38590 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15357ec sp=0x15357ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 44 gp=0x17d6248 m=nil [GC worker (idle)]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3fbc, 0x189e5e8, 0x1a, 0xa, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1535f90 sp=0x1535f7c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcBgMarkWorker() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1535fec sp=0x1535f90 pc=0x38590 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1535fec sp=0x1535fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 45 gp=0x17d6368 m=nil [GC worker (idle)]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3fbc, 0x189e600, 0x1a, 0xa, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1536790 sp=0x153677c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcBgMarkWorker() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x15367ec sp=0x1536790 pc=0x38590 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15367ec sp=0x15367ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 46 gp=0x17d6488 m=nil [GC worker (idle)]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3fbc, 0x1701290, 0x1a, 0xa, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1536f90 sp=0x1536f7c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gcBgMarkWorker() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1536fec sp=0x1536f90 pc=0x38590 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1536fec sp=0x1536fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by runtime.gcBgMarkStartWorkers in goroutine 50 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 83 gp=0x17d6908 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7b08, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1773d14 sp=0x1773d00 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7af8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1773d2c sp=0x1773d14 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7af8, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1773d40 sp=0x1773d2c pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x174abf8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1773d54 sp=0x1773d40 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x174abe0, {0x17cc5a0, 0x3, 0x3}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1773d9c sp=0x1773d54 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x174abe0, {0x17cc5a0, 0x3, 0x3}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1773dc8 sp=0x1773d9c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x151aaa0, {0x17cc5a0, 0x3, 0x3}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1773df4 sp=0x1773dc8 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x151aaa0, {0x17cc5a0, 0x3, 0x3}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x1773e14 sp=0x1773df4 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadAtLeast({0x882848, 0x151aaa0}, {0x17cc5a0, 0x3, 0x3}, 0x3) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1773e40 sp=0x1773e14 pc=0x1042c0 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadFull(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:354 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x152f9c0, {0x8874f0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/shannon.go:124 +0x3a0 fp=0x1773f04 sp=0x1773e40 pc=0x48faf4 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x17d2008) Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:276 +0x68 fp=0x1773fe4 sp=0x1773f04 pc=0x48c330 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:260 +0x28 fp=0x1773fec sp=0x1773fe4 pc=0x48c29c Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1773fec sp=0x1773fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 31 Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:260 +0x98 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 4 gp=0x14845a8 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7c48, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16cfe5c sp=0x16cfe48 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7c38, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x16cfe74 sp=0x16cfe5c pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7c38, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x16cfe88 sp=0x16cfe74 pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1899c88, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x16cfe9c sp=0x16cfe88 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).RawRead(0x1899c70, 0x1710720) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x16cfec8 sp=0x16cfe9c pc=0x10f788 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*rawConn).Read(0x14314a0, 0x1710720) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x16cfee8 sp=0x16cfec8 pc=0x190d28 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x140fb90, 0x17106f0, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x16cff18 sp=0x16cfee8 pc=0x548824 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Dec 29 04:48:30 stereo go-librespot[5962]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x14982d8, {0x16d2000, 0x10000, 0x10000}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x16cff9c sp=0x16cff18 pc=0x550194 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/grandcat/zeroconf.(*Server).recv6(0x1682fc0, 0x14982d0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x16cffe0 sp=0x16cff9c pc=0x5a3290 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x16cffec sp=0x16cffe0 pc=0x5a2cf8 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16cffec sp=0x16cffec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 20 Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 30 gp=0x17d70e8 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x16cf674 sp=0x16cf660 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x16cf774, 0x16cf73c, 0x0, 0x0, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x16cf714 sp=0x16cf674 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x14f66e0) Dec 29 04:48:30 stereo go-librespot[5962]: /src/player/player.go:201 +0x1fc fp=0x16cf7e4 sp=0x16cf714 pc=0x513660 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/player/player.go:183 +0x28 fp=0x16cf7ec sp=0x16cf7e4 pc=0x513240 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x16cf7ec sp=0x16cf7ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/player/player.go:183 +0x218 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 28 gp=0x17d7328 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7ba8, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1454ad4 sp=0x1454ac0 pc=0x5d0c0 Dec 29 04:48:30 stereo volumio[1152]: error: Failed to send command to Spotify local API: /player/prev: Error: socket hang up Dec 29 04:48:30 stereo volumio[1152]: info: Connection to go-librespot Websocket closed Dec 29 04:48:30 stereo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7b98, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1454aec sp=0x1454ad4 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7b98, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1454b00 sp=0x1454aec pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x174a068, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1454b14 sp=0x1454b00 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x174a050, {0x14bd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1454b5c sp=0x1454b14 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x174a050, {0x14bd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1454b88 sp=0x1454b5c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x1431b18, {0x14bd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1454bb4 sp=0x1454b88 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x1431b18, {0x14bd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x1454bd4 sp=0x1454bb4 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*atLeastReader).Read(0x188a590, {0x14bd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1454c00 sp=0x1454bd4 pc=0x27c680 Dec 29 04:48:30 stereo go-librespot[5962]: bytes.(*Buffer).ReadFrom(0x14b1a4c, {0x883674, 0x188a590}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1454c3c sp=0x1454c00 pc=0x139bd0 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readFromUntil(0x14b18c8, {0x882848, 0x1431b18}, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1454c64 sp=0x1454c3c pc=0x27c8dc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecordOrCCS(0x14b18c8, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1454dc8 sp=0x1454c64 pc=0x279fdc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecord(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).Read(0x14b18c8, {0x14dd000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1454df8 sp=0x1454dc8 pc=0x27fe4c Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).Read(0x1499bf0, {0x154cd24, 0x9, 0x9}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1454e1c sp=0x1454df8 pc=0x2be440 Dec 29 04:48:30 stereo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadAtLeast({0x882a3c, 0x1499bf0}, {0x154cd24, 0x9, 0x9}, 0x9) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1454e48 sp=0x1454e1c pc=0x1042c0 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadFull(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:354 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.http2readFrameHeader({0x154cd24, 0x9, 0x9}, {0x882a3c, 0x1499bf0}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1454e70 sp=0x1454e48 pc=0x2f733c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Framer).ReadFrame(0x154cd00) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1454eec sp=0x1454e70 pc=0x2f7ad4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2clientConnReadLoop).run(0x1454fdc) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1454fa4 sp=0x1454eec pc=0x31c2f0 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2ClientConn).readLoop(0x14ae108) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1454fe4 sp=0x1454fa4 pc=0x31b7e4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1454fec sp=0x1454fe4 pc=0x314830 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1454fec sp=0x1454fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*http2Transport).newClientConn in goroutine 27 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 82 gp=0x1718248 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x15306a8 sp=0x1530694 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x15307a4, 0x153076c, 0x0, 0x0, 0x5, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1530748 sp=0x15306a8 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x177a148) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x15307e4 sp=0x1530748 pc=0x474738 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.newConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x15307ec sp=0x15307e4 pc=0x47432c Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15307ec sp=0x15307ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by nhooyr.io/websocket.newConn in goroutine 31 Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 8 gp=0x1719568 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7a68, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1774ad4 sp=0x1774ac0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7a58, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1774aec sp=0x1774ad4 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7a58, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1774b00 sp=0x1774aec pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1895e18, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1774b14 sp=0x1774b00 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x1895e00, {0x16fb000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1774b5c sp=0x1774b14 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x1895e00, {0x16fb000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1774b88 sp=0x1774b5c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x151aee8, {0x16fb000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1774bb4 sp=0x1774b88 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x151aee8, {0x16fb000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x1774bd4 sp=0x1774bb4 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*atLeastReader).Read(0x170cc90, {0x16fb000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1774c00 sp=0x1774bd4 pc=0x27c680 Dec 29 04:48:30 stereo go-librespot[5962]: bytes.(*Buffer).ReadFrom(0x154938c, {0x883674, 0x170cc90}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1774c3c sp=0x1774c00 pc=0x139bd0 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readFromUntil(0x1549208, {0x882848, 0x151aee8}, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1774c64 sp=0x1774c3c pc=0x27c8dc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecordOrCCS(0x1549208, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1774dc8 sp=0x1774c64 pc=0x279fdc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecord(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).Read(0x1549208, {0x1853000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1774df8 sp=0x1774dc8 pc=0x27fe4c Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).Read(0x184e330, {0x16d00a4, 0x9, 0x9}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1774e1c sp=0x1774df8 pc=0x2be440 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadAtLeast({0x882a3c, 0x184e330}, {0x16d00a4, 0x9, 0x9}, 0x9) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1774e48 sp=0x1774e1c pc=0x1042c0 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadFull(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:354 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.http2readFrameHeader({0x16d00a4, 0x9, 0x9}, {0x882a3c, 0x184e330}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1774e70 sp=0x1774e48 pc=0x2f733c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Framer).ReadFrame(0x16d0080) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1774eec sp=0x1774e70 pc=0x2f7ad4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2clientConnReadLoop).run(0x1774fdc) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1774fa4 sp=0x1774eec pc=0x31c2f0 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2ClientConn).readLoop(0x1850008) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1774fe4 sp=0x1774fa4 pc=0x31b7e4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1774fec sp=0x1774fe4 pc=0x314830 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1774fec sp=0x1774fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*http2Transport).newClientConn in goroutine 7 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 32 gp=0x17d7688 m=nil [chan receive]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3f90, 0x1510270, 0xe, 0x7, 0x2) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1443748 sp=0x1443734 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv(0x1510240, 0x14437d0, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1443784 sp=0x1443748 pc=0x20078 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv2(0x1510240, 0x14437d0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1443798 sp=0x1443784 pc=0x1fbbc Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).withAppPlayer.func1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:268 +0x68 fp=0x14437ec sp=0x1443798 pc=0x63e794 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14437ec sp=0x14437ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by main.(*App).withAppPlayer in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:265 +0x464 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 33 gp=0x17d77a8 m=nil [chan receive]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e3f90, 0x1510230, 0xe, 0x7, 0x2) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1443f40 sp=0x1443f2c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv(0x1510200, 0x1443fe0, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1443f7c sp=0x1443f40 pc=0x20078 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.chanrecv2(0x1510200, 0x1443fe0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/chan.go:447 +0x20 fp=0x1443f90 sp=0x1443f7c pc=0x1fbbc Dec 29 04:48:30 stereo go-librespot[5962]: main.(*App).withAppPlayer.func2() Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:284 +0x6c fp=0x1443fec sp=0x1443f90 pc=0x63e330 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1443fec sp=0x1443fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by main.(*App).withAppPlayer in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/main.go:281 +0x504 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 66 gp=0x17d78c8 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7d88, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x15375e8 sp=0x15375d4 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7d78, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1537600 sp=0x15375e8 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7d78, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1537614 sp=0x1537600 pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1899be8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1537628 sp=0x1537614 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Accept(0x1899bd0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1537670 sp=0x1537628 pc=0x10eb84 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).accept(0x1899bd0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x15376d8 sp=0x1537670 pc=0x17e4c4 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPListener).accept(0x18c9788) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x15376f0 sp=0x15376d8 pc=0x196900 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPListener).Accept(0x18c9788) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x153770c sp=0x15376f0 pc=0x19596c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*onceCloseListener).Accept(0x14f2540) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x34 fp=0x1537724 sp=0x153770c pc=0x362b54 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*Server).Serve(0x1478e68, {0x886cb8, 0x18c9788}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x15377bc sp=0x1537724 pc=0x341210 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.Serve(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2794 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Dec 29 04:48:30 stereo go-librespot[5962]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x15377ec sp=0x15377bc pc=0x5a8184 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x15377ec sp=0x15377ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Dec 29 04:48:30 stereo go-librespot[5962]: /src/zeroconf/zeroconf.go:280 +0x160 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 84 gp=0x1718008 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1530eb8 sp=0x1530ea4 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x1530fd4, 0x1530f7c, 0x0, 0x0, 0x2, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1530f58 sp=0x1530eb8 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x17d2008) Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:355 +0x8c fp=0x1530fe4 sp=0x1530f58 pc=0x48cb50 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:264 +0x28 fp=0x1530fec sp=0x1530fe4 pc=0x48c248 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1530fec sp=0x1530fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 31 Dec 29 04:48:30 stereo go-librespot[5962]: /src/ap/ap.go:264 +0x15c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 85 gp=0x17197a8 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c79c8, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1849940 sp=0x184992c pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c79b8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1849958 sp=0x1849940 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c79b8, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x184996c sp=0x1849958 pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x16fd058, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1849980 sp=0x184996c pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x16fd040, {0x18c0000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x18499c8 sp=0x1849980 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x16fd040, {0x18c0000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x18499f4 sp=0x18499c8 pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x16856f8, {0x18c0000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1849a20 sp=0x18499f4 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x16856f8, {0x18c0000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x1849a40 sp=0x1849a20 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*atLeastReader).Read(0x170c000, {0x18c0000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1849a6c sp=0x1849a40 pc=0x27c680 Dec 29 04:48:30 stereo go-librespot[5962]: bytes.(*Buffer).ReadFrom(0x18a284c, {0x883674, 0x170c000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1849aa8 sp=0x1849a6c pc=0x139bd0 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readFromUntil(0x18a26c8, {0x882848, 0x16856f8}, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1849ad0 sp=0x1849aa8 pc=0x27c8dc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecordOrCCS(0x18a26c8, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1849c34 sp=0x1849ad0 pc=0x279fdc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecord(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).Read(0x18a26c8, {0x18c1000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1849c64 sp=0x1849c34 pc=0x27fe4c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*readWriteCloserBody).Read(0x1800000, {0x18c1000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/transport.go:2429 +0xec fp=0x1849c84 sp=0x1849c64 pc=0x357b00 Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).fill(0x18a0000) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1849ca8 sp=0x1849c84 pc=0x2bddb4 Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).ReadByte(0x18a0000) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x1849cb4 sp=0x1849ca8 pc=0x2be638 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.readFrameHeader(0x18a0000, {0x177a178, 0x8, 0x8}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1849cf4 sp=0x1849cb4 pc=0x47788c Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x177a148, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1849db4 sp=0x1849cf4 pc=0x47a4f0 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).readLoop(0x177a148, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1849e78 sp=0x1849db4 pc=0x479fd8 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).reader(0x177a148, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1849f04 sp=0x1849e78 pc=0x47b1ec Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).Reader(...) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).Read(0x177a148, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1849f2c sp=0x1849f04 pc=0x4798bc Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x18e6fd8) Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:188 +0x58 fp=0x1849fe4 sp=0x1849f2c pc=0x531d64 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:125 +0x28 fp=0x1849fec sp=0x1849fe4 pc=0x53383c Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1849fec sp=0x1849fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 31 Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:125 +0x98 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 86 gp=0x17198c8 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1531e98 sp=0x1531e84 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x1531fd4, 0x1531f60, 0x0, 0x0, 0x2, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1531f38 sp=0x1531e98 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x18e6fd8) Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:138 +0x8c fp=0x1531fe4 sp=0x1531f38 pc=0x5318dc Dec 29 04:48:30 stereo go-librespot[5962]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:129 +0x28 fp=0x1531fec sp=0x1531fe4 pc=0x5337e8 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1531fec sp=0x1531fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 31 Dec 29 04:48:30 stereo go-librespot[5962]: /src/dealer/dealer.go:129 +0x15c Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 100 gp=0x1485e68 m=nil [select]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1534ea8 sp=0x1534e94 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.selectgo(0x1534fa4, 0x1534f6c, 0x0, 0x0, 0x5, 0x1) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1534f48 sp=0x1534ea8 pc=0x70e78 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x15fc788) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1534fe4 sp=0x1534f48 pc=0x474738 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.newConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1534fec sp=0x1534fe4 pc=0x47432c Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1534fec sp=0x1534fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by nhooyr.io/websocket.newConn in goroutine 67 Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 93 gp=0x1402ea8 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7928, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1455ad4 sp=0x1455ac0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7918, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1455aec sp=0x1455ad4 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7918, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1455b00 sp=0x1455aec pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x1523dc8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1455b14 sp=0x1455b00 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x1523db0, {0x149a000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1455b5c sp=0x1455b14 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x1523db0, {0x149a000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1455b88 sp=0x1455b5c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x14302a8, {0x149a000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1455bb4 sp=0x1455b88 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x14302a8, {0x149a000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x1455bd4 sp=0x1455bb4 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*atLeastReader).Read(0x167cb30, {0x149a000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1455c00 sp=0x1455bd4 pc=0x27c680 Dec 29 04:48:30 stereo go-librespot[5962]: bytes.(*Buffer).ReadFrom(0x14b084c, {0x883674, 0x167cb30}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1455c3c sp=0x1455c00 pc=0x139bd0 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readFromUntil(0x14b06c8, {0x882848, 0x14302a8}, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1455c64 sp=0x1455c3c pc=0x27c8dc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecordOrCCS(0x14b06c8, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1455dc8 sp=0x1455c64 pc=0x279fdc Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).readRecord(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:588 Dec 29 04:48:30 stereo go-librespot[5962]: crypto/tls.(*Conn).Read(0x14b06c8, {0x149c000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1455df8 sp=0x1455dc8 pc=0x27fe4c Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).Read(0x164acc0, {0x17627a4, 0x9, 0x9}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1455e1c sp=0x1455df8 pc=0x2be440 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadAtLeast({0x882a3c, 0x164acc0}, {0x17627a4, 0x9, 0x9}, 0x9) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1455e48 sp=0x1455e1c pc=0x1042c0 Dec 29 04:48:30 stereo go-librespot[5962]: io.ReadFull(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/io.go:354 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.http2readFrameHeader({0x17627a4, 0x9, 0x9}, {0x882a3c, 0x164acc0}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1455e70 sp=0x1455e48 pc=0x2f733c Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Framer).ReadFrame(0x1762780) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1455eec sp=0x1455e70 pc=0x2f7ad4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2clientConnReadLoop).run(0x1455fdc) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1455fa4 sp=0x1455eec pc=0x31c2f0 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2ClientConn).readLoop(0x14ae208) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1455fe4 sp=0x1455fa4 pc=0x31b7e4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*http2Transport).newClientConn.gowrap1() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1455fec sp=0x1455fe4 pc=0x314830 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1455fec sp=0x1455fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*http2Transport).newClientConn in goroutine 92 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 67 gp=0x1606008 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c7888, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x177987c sp=0x1779868 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c7878, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1779894 sp=0x177987c pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c7878, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x17798a8 sp=0x1779894 pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x169c018, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x17798bc sp=0x17798a8 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x169c000, {0x149d000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1779904 sp=0x17798bc pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x169c000, {0x149d000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1779930 sp=0x1779904 pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x151a020, {0x149d000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x177995c sp=0x1779930 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x151a020, {0x149d000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x177997c sp=0x177995c pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: io.(*multiReader).Read(0x18009c0, {0x149d000, 0x1000, 0x1000}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x17799a8 sp=0x177997c pc=0x105528 Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).fill(0x164ade0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x17799cc sp=0x17799a8 pc=0x2bddb4 Dec 29 04:48:30 stereo go-librespot[5962]: bufio.(*Reader).ReadByte(0x164ade0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x17799d8 sp=0x17799cc pc=0x2be638 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.readFrameHeader(0x164ade0, {0x15fc7b8, 0x8, 0x8}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1779a18 sp=0x17799d8 pc=0x47788c Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x15fc788, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1779ad8 sp=0x1779a18 pc=0x47a4f0 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).readLoop(0x15fc788, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1779b9c sp=0x1779ad8 pc=0x479fd8 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).reader(0x15fc788, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1779c28 sp=0x1779b9c pc=0x47b1ec Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).Reader(...) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Dec 29 04:48:30 stereo go-librespot[5962]: nhooyr.io/websocket.(*Conn).Read(0x15fc788, {0x8874d0, 0xd0ad00}) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1779c50 sp=0x1779c28 pc=0x4798bc Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x1779ccc sp=0x1779c50 pc=0x633988 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.HandlerFunc.ServeHTTP(0x1430190, {0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1779cdc sp=0x1779ccc pc=0x33d7f4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*ServeMux).ServeHTTP(0x1474000, {0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1779d18 sp=0x1779cdc pc=0x33f654 Dec 29 04:48:30 stereo go-librespot[5962]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1779d40 sp=0x1779d18 pc=0x633388 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.HandlerFunc.ServeHTTP(0x140e190, {0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1779d50 sp=0x1779d40 pc=0x33d7f4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.serverHandler.ServeHTTP({0x14780a8}, {0x886dec, 0x152cdc8}, 0x152cd28) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1779d6c sp=0x1779d50 pc=0x340de4 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*conn).serve(0x1604000, {0x887510, 0x1426198}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1779fdc sp=0x1779d6c pc=0x33c034 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*Server).Serve.gowrap3() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1779fec sp=0x1779fdc pc=0x341688 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1779fec sp=0x1779fec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*Server).Serve in goroutine 37 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:3285 +0x468 Dec 29 04:48:30 stereo go-librespot[5962]: goroutine 115 gp=0x1690008 m=nil [IO wait]: Dec 29 04:48:30 stereo go-librespot[5962]: runtime.gopark(0x7e40f0, 0x757c77e8, 0x2, 0x2, 0x5) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x14456b4 sp=0x14456a0 pc=0x5d0c0 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.netpollblock(0x757c77d8, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x14456cc sp=0x14456b4 pc=0x548cc Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.runtime_pollWait(0x757c77d8, 0x72) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x14456e0 sp=0x14456cc pc=0x8f4a8 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).wait(0x174a018, 0x72, 0x0) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x14456f4 sp=0x14456e0 pc=0x10a318 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*pollDesc).waitRead(...) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Dec 29 04:48:30 stereo go-librespot[5962]: internal/poll.(*FD).Read(0x174a000, {0x17da00d, 0x1, 0x1}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x144573c sp=0x14456f4 pc=0x10b504 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*netFD).Read(0x174a000, {0x17da00d, 0x1, 0x1}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1445768 sp=0x144573c pc=0x17c5d0 Dec 29 04:48:30 stereo go-librespot[5962]: net.(*conn).Read(0x1706010, {0x17da00d, 0x1, 0x1}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1445794 sp=0x1445768 pc=0x18caec Dec 29 04:48:30 stereo go-librespot[5962]: net.(*TCPConn).Read(0x1706010, {0x17da00d, 0x1, 0x1}) Dec 29 04:48:30 stereo go-librespot[5962]: :1 +0x44 fp=0x14457b4 sp=0x1445794 pc=0x19fd40 Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*connReader).backgroundRead(0x17da000) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:681 +0x40 fp=0x14457e4 sp=0x14457b4 pc=0x335cfc Dec 29 04:48:30 stereo go-librespot[5962]: net/http.(*connReader).startBackgroundRead.gowrap2() Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:677 +0x28 fp=0x14457ec sp=0x14457e4 pc=0x335c34 Dec 29 04:48:30 stereo go-librespot[5962]: runtime.goexit({}) Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x14457ec sp=0x14457ec pc=0x93d6c Dec 29 04:48:30 stereo go-librespot[5962]: created by net/http.(*connReader).startBackgroundRead in goroutine 114 Dec 29 04:48:30 stereo go-librespot[5962]: /usr/local/go/src/net/http/server.go:677 +0x160 Dec 29 04:48:30 stereo go-librespot[5961]: Aborted Dec 29 04:48:32 stereo volumio[1152]: info: Getting Spotify volume Dec 29 04:48:32 stereo volumio[1152]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 04:48:32 stereo volumio[1152]: Error: connect ECONNREFUSED 127.0.0.1:9879 Dec 29 04:48:32 stereo volumio[1152]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Dec 29 04:48:32 stereo volumio[1152]: errno: -111, Dec 29 04:48:32 stereo volumio[1152]: code: 'ECONNREFUSED', Dec 29 04:48:32 stereo volumio[1152]: syscall: 'connect', Dec 29 04:48:32 stereo volumio[1152]: address: '127.0.0.1', Dec 29 04:48:32 stereo volumio[1152]: port: 9879, Dec 29 04:48:32 stereo volumio[1152]: response: undefined Dec 29 04:48:32 stereo volumio[1152]: } Dec 29 04:48:32 stereo volumio[1152]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 04:48:33 stereo sudo[5984]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-29 04:47' Dec 29 04:48:33 stereo sudo[5984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"