Feb 10 12:41:00 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:00+05:00" level=debug msg="fetched chunk 13/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:06 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:06+05:00" level=trace msg="sent dealer ping" Feb 10 12:41:06 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:06+05:00" level=trace msg="received dealer pong" Feb 10 12:41:10 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:10+05:00" level=debug msg="fetched chunk 14/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:21 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:21+05:00" level=debug msg="fetched chunk 15/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:31 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:31+05:00" level=debug msg="fetched chunk 16/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:36 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:36+05:00" level=trace msg="sent dealer ping" Feb 10 12:41:36 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:36+05:00" level=trace msg="received dealer pong" Feb 10 12:41:42 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:42+05:00" level=debug msg="fetched chunk 17/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:54 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:54+05:00" level=debug msg="fetched chunk 18/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:41:56 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:56+05:00" level=trace msg="received accesspoint ping" Feb 10 12:41:56 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:41:56+05:00" level=trace msg="received accesspoint pong ack" Feb 10 12:42:05 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:05+05:00" level=debug msg="fetched chunk 19/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:42:05 my-volumio-digi volumio[1367]: verbose: New Socket.io Connection to 192.168.11.227:3000 from 192.168.11.157 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: Discovery: Getting this device information Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: Discovery: Getting this device information Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:42:05 my-volumio-digi volumio[1367]: verbose: New Socket.io Connection to 192.168.11.227:3000 from 192.168.11.157 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 10 12:42:05 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 10 12:42:06 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:06+05:00" level=trace msg="sent dealer ping" Feb 10 12:42:06 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:06+05:00" level=trace msg="received dealer pong" Feb 10 12:42:09 my-volumio-digi volumio[1367]: verbose: New Socket.io Connection to 192.168.11.227:3000 from 192.168.11.157 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: Discovery: Getting this device information Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: Discovery: Getting this device information Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:42:09 my-volumio-digi volumio[1367]: verbose: New Socket.io Connection to 192.168.11.227:3000 from 192.168.11.157 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 10 12:42:09 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 10 12:42:16 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:16+05:00" level=debug msg="fetched chunk 20/26, size: 524288" uri="spotify:track:65dF4jvFSR3YwXJxUx8cEl" Feb 10 12:42:16 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:16+05:00" level=info msg="playback was transferred to My Volumio 3" Feb 10 12:42:16 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:16+05:00" level=trace msg="closed output device because of stop command" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1135" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 411" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="put connect state inactive" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=trace msg="emitting websocket event: inactive" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=trace msg="emitting websocket event: stopped" Feb 10 12:42:17 my-volumio-digi volumio[1367]: SPOTIFY: received: {"type":"inactive","data":null} Feb 10 12:42:17 my-volumio-digi volumio[1367]: error: Failed to decode event: inactive Feb 10 12:42:17 my-volumio-digi volumio[1367]: SPOTIFY: received: {"type":"stopped","data":{"play_origin":""}} Feb 10 12:42:17 my-volumio-digi volumio[1367]: SPOTIFY: PUSH STATE SPOTIFY Feb 10 12:42:17 my-volumio-digi volumio[1367]: SPOTIFY: {"status":"stop","service":"spop","title":"Rishte Naate (From \"De Dana Dan\")","artist":"Rahat Fateh Ali Khan, Suzanne D'Mello","album":"Tera Mera Saath Ho","albumart":"https://i.scdn.co/image/ab67616d00001e024932ac0b8bc756402d22f175","uri":"spotify:track:65dF4jvFSR3YwXJxUx8cEl","trackType":"spotify","seek":184000,"duration":286,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::servicePushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::pushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 16 Feb 10 12:42:17 my-volumio-digi volumio[1367]: verbose: STATE SERVICE {"status":"stop","service":"spop","title":"Rishte Naate (From \"De Dana Dan\")","artist":"Rahat Fateh Ali Khan, Suzanne D'Mello","album":"Tera Mera Saath Ho","albumart":"https://i.scdn.co/image/ab67616d00001e024932ac0b8bc756402d22f175","uri":"spotify:track:65dF4jvFSR3YwXJxUx8cEl","trackType":"spotify","seek":184000,"duration":286,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null} Feb 10 12:42:17 my-volumio-digi volumio[1367]: verbose: CURRENT POSITION 16 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::syncState stateService stop Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::play index undefined Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::pushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 17 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 17 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::startPlaybackTimer Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 17 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: [1770709337460] ControllerSpotify::clearAddPlayTrack Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: Sending Spotify command with payload to local API: /player/play Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreStateMachine::pushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 17 Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioPushState Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="dealer connection closed" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: time="2026-02-10T12:42:17+05:00" level=debug msg="dealer recv loop stopped" Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: panic: send on closed channel Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 62 gp=0x1bcc248 m=7 mp=0x184a108 [running]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: panic({0x6cfbf0, 0x881b80}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/panic.go:779 +0x12c fp=0x1b01f48 sp=0x1b01ef4 pc=0x58bf8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.chansend(0x1c0e140, 0x1b01fa8, 0x1, 0x63e7c8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/chan.go:283 +0x5e4 fp=0x1b01f80 sp=0x1b01f48 pc=0x1f474 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.chansend1(0x1c0e140, 0x1b01fa8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/chan.go:145 +0x28 fp=0x1b01f98 sp=0x1b01f80 pc=0x1ee8c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).withAppPlayer.func1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:275 +0x9c fp=0x1b01fec sp=0x1b01f98 pc=0x63e7c8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1b01fec sp=0x1b01fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by main.(*App).withAppPlayer in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:265 +0x464 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 1 gp=0x1802128 m=nil [select, 86 minutes]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1cc0d00 sp=0x1cc0cec pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.selectgo(0x1cc0e00, 0x1a5bdcc, 0x0, 0x0, 0x2, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1cc0da0 sp=0x1cc0d00 pc=0x70e78 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x1d2a0c0, 0x1cc0e90) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/zeroconf/zeroconf.go:283 +0x228 fp=0x1cc0e44 sp=0x1cc0da0 pc=0x5a8088 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).withAppPlayer(0x1a00880, {0x8874f0, 0xd0ad00}, 0x1994180) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:321 +0x554 fp=0x1cc0ed0 sp=0x1cc0e44 pc=0x63db54 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).withCredentials(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:193 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).SpotifyToken(0x1a00880, {0x8874f0, 0xd0ad00}, {0x1a60840, 0x1c}, {0x1a6a140, 0x13c}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:185 +0xd8 fp=0x1cc0f00 sp=0x1cc0ed0 pc=0x63cfa8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.main() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:557 +0x588 fp=0x1cc0fa8 sp=0x1cc0f00 pc=0x63feb4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.main() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:271 +0x2fc fp=0x1cc0fec sp=0x1cc0fa8 pc=0x5cb30 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1cc0fec sp=0x1cc0fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 2 gp=0x1802c68 m=nil [force gc (idle), 67 minutes]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4100, 0xcdf428, 0x11, 0xa, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1844fd4 sp=0x1844fc0 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goparkunlock(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:408 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.forcegchelper() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:326 +0xe4 fp=0x1844fec sp=0x1844fd4 pc=0x5cefc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1844fec sp=0x1844fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.init.5 in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:314 +0x1c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 3 gp=0x1802d88 m=nil [GC sweep wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4100, 0xcdfbe0, 0xc, 0x9, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x18457c4 sp=0x18457b0 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goparkunlock(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:408 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.bgsweep(0x1874000) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgcsweep.go:318 +0x11c fp=0x18457e4 sp=0x18457c4 pc=0x45848 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcenable.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:203 +0x28 fp=0x18457ec sp=0x18457e4 pc=0x35968 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18457ec sp=0x18457ec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcenable in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:203 +0x74 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 4 gp=0x1802ea8 m=nil [GC scavenge wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4100, 0xce0208, 0xd, 0xa, 0x2) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1845fb4 sp=0x1845fa0 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goparkunlock(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:408 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.(*scavengerState).park(0xce0208) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1845fc8 sp=0x1845fb4 pc=0x42b68 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.bgscavenge(0x1874000) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1845fe4 sp=0x1845fc8 pc=0x432a0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcenable.gowrap2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:204 +0x28 fp=0x1845fec sp=0x1845fe4 pc=0x35914 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1845fec sp=0x1845fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcenable in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:204 +0xbc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 18 gp=0x1884488 m=nil [finalizer wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3fac, 0xd0ad9c, 0x10, 0xa, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x184078c sp=0x1840778 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.runfinq() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mfinal.go:194 +0x110 fp=0x18407ec sp=0x184078c pc=0x34754 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18407ec sp=0x18407ec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.createfing in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mfinal.go:164 +0x5c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 21 gp=0x18857a8 m=nil [IO wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebef18, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x185ad28 sp=0x185ad14 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebef08, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x185ad40 sp=0x185ad28 pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebef08, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x185ad54 sp=0x185ad40 pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1a17328, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x185ad68 sp=0x185ad54 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Accept(0x1a17310) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x185adb0 sp=0x185ad68 pc=0x10eb84 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).accept(0x1a17310) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x185ae18 sp=0x185adb0 pc=0x17e4c4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPListener).accept(0x18ac780) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x185ae30 sp=0x185ae18 pc=0x196900 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPListener).Accept(0x18ac780) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x185ae4c sp=0x185ae30 pc=0x19596c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*onceCloseListener).Accept(0x1abc160) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x34 fp=0x185ae64 sp=0x185ae4c pc=0x362b54 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Server).Serve(0x1a770e8, {0x886cb8, 0x18ac780}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x185aefc sp=0x185ae64 pc=0x341210 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.Serve(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2794 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).serve(0x18a2cc0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:630 +0x974 fp=0x185afe4 sp=0x185aefc pc=0x6330b8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.NewApiServer.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:296 +0x28 fp=0x185afec sp=0x185afe4 pc=0x631de4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x185afec sp=0x185afec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by main.NewApiServer in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:296 +0x310 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 22 gp=0x18858c8 m=nil [GC worker (idle)]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3fbc, 0x1a4afc0, 0x1a, 0xa, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1840f90 sp=0x1840f7c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcBgMarkWorker() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1840fec sp=0x1840f90 pc=0x38590 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1840fec sp=0x1840fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 103 gp=0x19c8368 m=nil [runnable]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.newobject(0x711248) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/malloc.go:1389 +0x40 fp=0x1ca3dc8 sp=0x1ca3dc8 pc=0x276f0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*conn).Read(0x1d141a0, {0x198e964, 0x3, 0x3}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/net.go:181 +0xc4 fp=0x1ca3df4 sp=0x1ca3dc8 pc=0x18cb68 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPConn).Read(0x1d141a0, {0x198e964, 0x3, 0x3}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x44 fp=0x1ca3e14 sp=0x1ca3df4 pc=0x19fd40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: io.ReadAtLeast({0x882848, 0x1d141a0}, {0x198e964, 0x3, 0x3}, 0x3) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1ca3e40 sp=0x1ca3e14 pc=0x1042c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: io.ReadFull(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/io/io.go:354 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x1d24540, {0x8874f0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/ap/shannon.go:124 +0x3a0 fp=0x1ca3f04 sp=0x1ca3e40 pc=0x48faf4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1c22168) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/ap/ap.go:276 +0x68 fp=0x1ca3fe4 sp=0x1ca3f04 pc=0x48c330 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/ap/ap.go:390 +0x28 fp=0x1ca3fec sp=0x1ca3fe4 pc=0x48d010 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ca3fec sp=0x1ca3fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).reconnect in goroutine 71 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/ap/ap.go:390 +0x120 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 11 gp=0x19c8488 m=nil [IO wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebed38, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1cc6e84 sp=0x1cc6e70 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebed28, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1cc6e9c sp=0x1cc6e84 pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebed28, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1cc6eb0 sp=0x1cc6e9c pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1a16388, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1cc6ec4 sp=0x1cc6eb0 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).RawRead(0x1a16370, 0x26be0f0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x1cc6ef0 sp=0x1cc6ec4 pc=0x10f788 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*rawConn).Read(0x1830470, 0x26be0f0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x1cc6f10 sp=0x1cc6ef0 pc=0x190d28 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x18a04a0, 0x26be0c0, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1cc6f40 sp=0x1cc6f10 pc=0x548824 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/ipv4.(*payloadHandler).ReadFrom(0x1b420f8, {0x1cb0000, 0x10000, 0x10000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv4/payload_cmsg.go:31 +0x44c fp=0x1cc6f9c sp=0x1cc6f40 pc=0x54c80c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/grandcat/zeroconf.(*Server).recv4(0x18aa6c0, 0x1b420f0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:254 +0xec fp=0x1cc6fe0 sp=0x1cc6f9c pc=0x5a309c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x30 fp=0x1cc6fec sp=0x1cc6fe0 pc=0x5a2d54 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1cc6fec sp=0x1cc6fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 50 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:188 +0x7c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 23 gp=0x18859e8 m=nil [GC worker (idle)]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3fbc, 0x182b110, 0x1a, 0xa, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1841f90 sp=0x1841f7c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcBgMarkWorker() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1841fec sp=0x1841f90 pc=0x38590 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1841fec sp=0x1841fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 39 gp=0x19c87e8 m=nil [GC worker (idle)]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3fbc, 0x182b128, 0x1a, 0xa, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1b04f90 sp=0x1b04f7c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcBgMarkWorker() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x1b04fec sp=0x1b04f90 pc=0x38590 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1b04fec sp=0x1b04fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 7 gp=0x1803568 m=nil [GC worker (idle)]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3fbc, 0x182b140, 0x1a, 0xa, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1844790 sp=0x184477c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gcBgMarkWorker() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1310 +0xec fp=0x18447ec sp=0x1844790 pc=0x38590 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Feb 10 12:42:17 my-volumio-digi volumio[1367]: info: Connection to go-librespot Websocket closed Feb 10 12:42:17 my-volumio-digi volumio[1367]: error: Failed to send command to Spotify local API: /player/play: Error: socket hang up Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18447ec sp=0x18447ec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by runtime.gcBgMarkStartWorkers in goroutine 5 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/mgc.go:1234 +0x20 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 12 gp=0x18037a8 m=nil [IO wait, 86 minutes]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebec98, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x184665c sp=0x1846648 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebec88, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1846674 sp=0x184665c pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebec88, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1846688 sp=0x1846674 pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1a163d8, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x184669c sp=0x1846688 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).RawRead(0x1a163c0, 0x1aaa210) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:708 +0x164 fp=0x18466c8 sp=0x184669c pc=0x10f788 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*rawConn).Read(0x1830498, 0x1aaa210) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/rawconn.go:44 +0x38 fp=0x18466e8 sp=0x18466c8 pc=0x190d28 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/internal/socket.(*Conn).recvMsg(0x18a04b0, 0x1aaa1e0, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/rawconn_msg.go:27 +0x154 fp=0x1846718 sp=0x18466e8 pc=0x548824 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/internal/socket.(*Conn).RecvMsg(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/internal/socket/socket.go:247 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: golang.org/x/net/ipv6.(*payloadHandler).ReadFrom(0x1b42128, {0x1ac0000, 0x10000, 0x10000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/golang.org/x/net@v0.26.0/ipv6/payload_cmsg.go:31 +0x2ec fp=0x184679c sp=0x1846718 pc=0x550194 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/grandcat/zeroconf.(*Server).recv6(0x18aa6c0, 0x1b42120) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:282 +0xec fp=0x18467e0 sp=0x184679c pc=0x5a3290 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/grandcat/zeroconf.(*Server).mainloop.gowrap2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0x30 fp=0x18467ec sp=0x18467e0 pc=0x5a2cf8 Feb 10 12:42:17 my-volumio-digi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x18467ec sp=0x18467ec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by github.com/grandcat/zeroconf.(*Server).mainloop in goroutine 50 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/grandcat/zeroconf@v1.0.0/server.go:191 +0xe8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 1033215 gp=0x1bcc008 m=nil [IO wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebeb58, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1d57eb4 sp=0x1d57ea0 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebeb48, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1d57ecc sp=0x1d57eb4 pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebeb48, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1d57ee0 sp=0x1d57ecc pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1c6efb8, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1d57ef4 sp=0x1d57ee0 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Read(0x1c6efa0, {0x2e02c8d, 0x1, 0x1}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1d57f3c sp=0x1d57ef4 pc=0x10b504 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).Read(0x1c6efa0, {0x2e02c8d, 0x1, 0x1}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1d57f68 sp=0x1d57f3c pc=0x17c5d0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*conn).Read(0x1d14828, {0x2e02c8d, 0x1, 0x1}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1d57f94 sp=0x1d57f68 pc=0x18caec Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPConn).Read(0x1d14828, {0x2e02c8d, 0x1, 0x1}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x44 fp=0x1d57fb4 sp=0x1d57f94 pc=0x19fd40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*connReader).backgroundRead(0x2e02c80) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:681 +0x40 fp=0x1d57fe4 sp=0x1d57fb4 pc=0x335cfc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*connReader).startBackgroundRead.gowrap2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:677 +0x28 fp=0x1d57fec sp=0x1d57fe4 pc=0x335c34 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1d57fec sp=0x1d57fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*connReader).startBackgroundRead in goroutine 1037987 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:677 +0x160 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 63 gp=0x1bcc368 m=nil [runnable]: Feb 10 12:42:17 my-volumio-digi systemd[1]: go-librespot-daemon.service: Consumed 3min 27.439s CPU time. Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/url.parse({0x7ae7b2, 0x2e}, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/url/url.go:506 +0x708 fp=0x1cc7c90 sp=0x1cc7c90 pc=0x24bc40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/url.Parse({0x7ae7b2, 0x2e}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/url/url.go:476 +0x68 fp=0x1cc7cd4 sp=0x1cc7c90 pc=0x24b288 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/session.retrieveClientToken(0x189ba00, {0x18b2420, 0x28}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/session/client_token.go:36 +0x308 fp=0x1cc7d6c sp=0x1cc7cd4 pc=0x544884 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/session.NewSessionFromOptions({0x8874f0, 0xd0ad00}, 0x1cc7f18) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/session/session.go:70 +0x228 fp=0x1cc7ed8 sp=0x1cc7d6c pc=0x545aa8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).newAppPlayer(0x1a00880, {0x8874f0, 0xd0ad00}, {0x6daf48, 0x19860c0}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:121 +0x204 fp=0x1cc7f50 sp=0x1cc7ed8 pc=0x63cb28 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).SpotifyToken.(*App).withCredentials.func1({0x8874f0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:195 +0x26c fp=0x1cc7f90 sp=0x1cc7f50 pc=0x63d248 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*App).withAppPlayer.func2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:298 +0x14c fp=0x1cc7fec sp=0x1cc7f90 pc=0x63e410 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1cc7fec sp=0x1cc7fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by main.(*App).withAppPlayer in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/main.go:281 +0x504 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 64 gp=0x1bcc488 m=nil [IO wait, 12 minutes]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebedd8, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1b02de8 sp=0x1b02dd4 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebedc8, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1b02e00 sp=0x1b02de8 pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebedc8, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1b02e14 sp=0x1b02e00 pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1a16338, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1b02e28 sp=0x1b02e14 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Accept(0x1a16320) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:611 +0x294 fp=0x1b02e70 sp=0x1b02e28 pc=0x10eb84 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).accept(0x1a16320) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_unix.go:172 +0x20 fp=0x1b02ed8 sp=0x1b02e70 pc=0x17e4c4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPListener).accept(0x1b0a1b0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1b02ef0 sp=0x1b02ed8 pc=0x196900 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPListener).Accept(0x1b0a1b0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/tcpsock.go:327 +0x30 fp=0x1b02f0c sp=0x1b02ef0 pc=0x19596c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*onceCloseListener).Accept(0x18768a0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x34 fp=0x1b02f24 sp=0x1b02f0c pc=0x362b54 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Server).Serve(0x1aea328, {0x886cb8, 0x1b0a1b0}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3255 +0x314 fp=0x1b02fbc sp=0x1b02f24 pc=0x341210 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.Serve(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2794 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/zeroconf/zeroconf.go:280 +0x8c fp=0x1b02fec sp=0x1b02fbc pc=0x5a8184 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1b02fec sp=0x1b02fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/zeroconf/zeroconf.go:280 +0x160 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 83 gp=0x1ab85a8 m=nil [IO wait, 86 minutes]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebe8d8, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1cc187c sp=0x1cc1868 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebe8c8, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1cc1894 sp=0x1cc187c pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebe8c8, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1cc18a8 sp=0x1cc1894 pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x187c248, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1cc18bc sp=0x1cc18a8 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Read(0x187c230, {0x19cb000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1cc1904 sp=0x1cc18bc pc=0x10b504 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).Read(0x187c230, {0x19cb000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1cc1930 sp=0x1cc1904 pc=0x17c5d0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*conn).Read(0x1d140e0, {0x19cb000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1cc195c sp=0x1cc1930 pc=0x18caec Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPConn).Read(0x1d140e0, {0x19cb000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x44 fp=0x1cc197c sp=0x1cc195c pc=0x19fd40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: io.(*multiReader).Read(0x1c002b0, {0x19cb000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x1cc19a8 sp=0x1cc197c pc=0x105528 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bufio.(*Reader).fill(0x1a082a0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1cc19cc sp=0x1cc19a8 pc=0x2bddb4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bufio.(*Reader).ReadByte(0x1a082a0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bufio/bufio.go:269 +0x28 fp=0x1cc19d8 sp=0x1cc19cc pc=0x2be638 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.readFrameHeader(0x1a082a0, {0x1c462b8, 0x8, 0x8}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/frame.go:54 +0x74 fp=0x1cc1a18 sp=0x1cc19d8 pc=0x47788c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).readFrameHeader(0x1c46288, {0x8874d0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:188 +0xb4 fp=0x1cc1ad8 sp=0x1cc1a18 pc=0x47a4f0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).readLoop(0x1c46288, {0x8874d0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:146 +0x3c fp=0x1cc1b9c sp=0x1cc1ad8 pc=0x479fd8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).reader(0x1c46288, {0x8874d0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:315 +0x108 fp=0x1cc1c28 sp=0x1cc1b9c pc=0x47b1ec Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).Reader(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:30 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).Read(0x1c46288, {0x8874d0, 0xd0ad00}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/read.go:36 +0x30 fp=0x1cc1c50 sp=0x1cc1c28 pc=0x4798bc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).serve.func17({0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:600 +0x3c0 fp=0x1cc1ccc sp=0x1cc1c50 pc=0x633988 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.HandlerFunc.ServeHTTP(0x1899a18, {0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1cc1cdc sp=0x1cc1ccc pc=0x33d7f4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*ServeMux).ServeHTTP(0x1a00900, {0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1cc1d18 sp=0x1cc1cdc pc=0x33f654 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1cc1d40 sp=0x1cc1d18 pc=0x633388 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.HandlerFunc.ServeHTTP(0x18a1500, {0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1cc1d50 sp=0x1cc1d40 pc=0x33d7f4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.serverHandler.ServeHTTP({0x1a770e8}, {0x886dec, 0x1a76968}, 0x1a76148) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1cc1d6c sp=0x1cc1d50 pc=0x340de4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*conn).serve(0x1c18000, {0x887510, 0x18ac918}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1cc1fdc sp=0x1cc1d6c pc=0x33c034 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Server).Serve.gowrap3() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1cc1fec sp=0x1cc1fdc pc=0x341688 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1cc1fec sp=0x1cc1fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*Server).Serve in goroutine 21 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3285 +0x468 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 85 gp=0x1ab86c8 m=nil [select]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1b046a8 sp=0x1b04694 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.selectgo(0x1b047a4, 0x1b0476c, 0x0, 0x0, 0x5, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1b04748 sp=0x1b046a8 pc=0x70e78 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.(*Conn).timeoutLoop(0x1c46288) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:153 +0x10c fp=0x1b047e4 sp=0x1b04748 pc=0x474738 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: nhooyr.io/websocket.newConn.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x28 fp=0x1b047ec sp=0x1b047e4 pc=0x47432c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1b047ec sp=0x1b047ec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by nhooyr.io/websocket.newConn in goroutine 83 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/nhooyr.io/websocket@v1.8.7/conn_notjs.go:114 +0x544 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 1037987 gp=0x19c9328 m=nil [chan receive]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e3f90, 0x1c69070, 0xe, 0x7, 0x2) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1857bb0 sp=0x1857b9c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.chanrecv(0x1c69040, 0x1857c7c, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/chan.go:583 +0x4b0 fp=0x1857bec sp=0x1857bb0 pc=0x20078 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.chanrecv1(0x1c69040, 0x1857c7c) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/chan.go:442 +0x20 fp=0x1857c00 sp=0x1857bec pc=0x1fb98 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).handleRequest(0x18a2cc0, {{0x79134a, 0x4}, {0x6eba88, 0x19860a8}, 0x1c69040}, {0x886dec, 0x1a772c8}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:319 +0x74 fp=0x1857c8c sp=0x1857c00 pc=0x631f94 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).serve.func4({0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/cmd/daemon/api_server.go:412 +0x148 fp=0x1857ccc sp=0x1857c8c pc=0x634b60 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.HandlerFunc.ServeHTTP(0x18998d8, {0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1857cdc sp=0x1857ccc pc=0x33d7f4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*ServeMux).ServeHTTP(0x1a00900, {0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2683 +0x208 fp=0x1857d18 sp=0x1857cdc pc=0x33f654 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x1f8 fp=0x1857d40 sp=0x1857d18 pc=0x633388 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.HandlerFunc.ServeHTTP(0x18a1500, {0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2166 +0x34 fp=0x1857d50 sp=0x1857d40 pc=0x33d7f4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.serverHandler.ServeHTTP({0x1a770e8}, {0x886dec, 0x1a772c8}, 0x18a74a8) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3137 +0xe0 fp=0x1857d6c sp=0x1857d50 pc=0x340de4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*conn).serve(0x1c18480, {0x887510, 0x18ac918}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:2039 +0x61c fp=0x1857fdc sp=0x1857d6c pc=0x33c034 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Server).Serve.gowrap3() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3285 +0x38 fp=0x1857fec sp=0x1857fdc pc=0x341688 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1857fec sp=0x1857fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*Server).Serve in goroutine 21 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/server.go:3285 +0x468 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 968783 gp=0x1c6ab48 m=nil [IO wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebe838, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ca0afc sp=0x1ca0ae8 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebe828, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1ca0b14 sp=0x1ca0afc pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebe828, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1ca0b28 sp=0x1ca0b14 pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1c6f418, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ca0b3c sp=0x1ca0b28 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Read(0x1c6f400, {0x20dc000, 0xa000, 0xa000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1ca0b84 sp=0x1ca0b3c pc=0x10b504 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).Read(0x1c6f400, {0x20dc000, 0xa000, 0xa000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1ca0bb0 sp=0x1ca0b84 pc=0x17c5d0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*conn).Read(0x1fc3e20, {0x20dc000, 0xa000, 0xa000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1ca0bdc sp=0x1ca0bb0 pc=0x18caec Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPConn).Read(0x1fc3e20, {0x20dc000, 0xa000, 0xa000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x44 fp=0x1ca0bfc sp=0x1ca0bdc pc=0x19fd40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*atLeastReader).Read(0x180e090, {0x20dc000, 0xa000, 0xa000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1ca0c28 sp=0x1ca0bfc pc=0x27c680 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bytes.(*Buffer).ReadFrom(0x1c2914c, {0x883674, 0x180e090}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1ca0c64 sp=0x1ca0c28 pc=0x139bd0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readFromUntil(0x1c28fc8, {0x882848, 0x1fc3e20}, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1ca0c8c sp=0x1ca0c64 pc=0x27c8dc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readRecordOrCCS(0x1c28fc8, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1ca0df0 sp=0x1ca0c8c pc=0x279fdc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readRecord(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:588 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).Read(0x1c28fc8, {0x1b58000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1ca0e20 sp=0x1ca0df0 pc=0x27fe4c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*persistConn).Read(0x19ba218, {0x1b58000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:1977 +0x16c fp=0x1ca0e54 sp=0x1ca0e20 pc=0x3555cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bufio.(*Reader).fill(0x2e7b1a0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bufio/bufio.go:110 +0x10c fp=0x1ca0e78 sp=0x1ca0e54 pc=0x2bddb4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bufio.(*Reader).Peek(0x2e7b1a0, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bufio/bufio.go:148 +0x68 fp=0x1ca0e84 sp=0x1ca0e78 pc=0x2bdf38 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*persistConn).readLoop(0x19ba218) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:2141 +0x194 fp=0x1ca0fe4 sp=0x1ca0e84 pc=0x35615c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Transport).dialConn.gowrap2() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:1799 +0x28 fp=0x1ca0fec sp=0x1ca0fe4 pc=0x354a7c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ca0fec sp=0x1ca0fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*Transport).dialConn in goroutine 966239 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:1799 +0x13f4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 1037984 gp=0x1af8908 m=nil [IO wait]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e40f0, 0x74ebe978, 0x2, 0x2, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ca2ad4 sp=0x1ca2ac0 pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.netpollblock(0x74ebe968, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:573 +0x100 fp=0x1ca2aec sp=0x1ca2ad4 pc=0x548cc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.runtime_pollWait(0x74ebe968, 0x72) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/netpoll.go:345 +0x54 fp=0x1ca2b00 sp=0x1ca2aec pc=0x8f4a8 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).wait(0x1a8ad38, 0x72, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ca2b14 sp=0x1ca2b00 pc=0x10a318 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*pollDesc).waitRead(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: internal/poll.(*FD).Read(0x1a8ad20, {0x19d9000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/internal/poll/fd_unix.go:164 +0x238 fp=0x1ca2b5c sp=0x1ca2b14 pc=0x10b504 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*netFD).Read(0x1a8ad20, {0x19d9000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/fd_posix.go:55 +0x38 fp=0x1ca2b88 sp=0x1ca2b5c pc=0x17c5d0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*conn).Read(0x1fc2048, {0x19d9000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/net.go:179 +0x48 fp=0x1ca2bb4 sp=0x1ca2b88 pc=0x18caec Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net.(*TCPConn).Read(0x1fc2048, {0x19d9000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: :1 +0x44 fp=0x1ca2bd4 sp=0x1ca2bb4 pc=0x19fd40 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*atLeastReader).Read(0x1c00f20, {0x19d9000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:806 +0x78 fp=0x1ca2c00 sp=0x1ca2bd4 pc=0x27c680 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bytes.(*Buffer).ReadFrom(0x19b618c, {0x883674, 0x1c00f20}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bytes/buffer.go:211 +0xa4 fp=0x1ca2c3c sp=0x1ca2c00 pc=0x139bd0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readFromUntil(0x19b6008, {0x882848, 0x1fc2048}, 0x5) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:828 +0xd4 fp=0x1ca2c64 sp=0x1ca2c3c pc=0x27c8dc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readRecordOrCCS(0x19b6008, 0x0) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:626 +0x134 fp=0x1ca2dc8 sp=0x1ca2c64 pc=0x279fdc Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).readRecord(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:588 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: crypto/tls.(*Conn).Read(0x19b6008, {0x1903000, 0x1000, 0x1000}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/crypto/tls/conn.go:1370 +0x15c fp=0x1ca2df8 sp=0x1ca2dc8 pc=0x27fe4c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: bufio.(*Reader).Read(0x241e7e0, {0x19be5a4, 0x9, 0x9}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/bufio/bufio.go:241 +0x214 fp=0x1ca2e1c sp=0x1ca2df8 pc=0x2be440 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: io.ReadAtLeast({0x882a3c, 0x241e7e0}, {0x19be5a4, 0x9, 0x9}, 0x9) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1ca2e48 sp=0x1ca2e1c pc=0x1042c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: io.ReadFull(...) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/io/io.go:354 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.http2readFrameHeader({0x19be5a4, 0x9, 0x9}, {0x882a3c, 0x241e7e0}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:1638 +0x54 fp=0x1ca2e70 sp=0x1ca2e48 pc=0x2f733c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*http2Framer).ReadFrame(0x19be580) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:1902 +0x88 fp=0x1ca2eec sp=0x1ca2e70 pc=0x2f7ad4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*http2clientConnReadLoop).run(0x1ca2fdc) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:9334 +0x150 fp=0x1ca2fa4 sp=0x1ca2eec pc=0x31c2f0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*http2ClientConn).readLoop(0x19b0a08) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:9229 +0x68 fp=0x1ca2fe4 sp=0x1ca2fa4 pc=0x31b7e4 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*http2Transport).newClientConn.gowrap1() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0x28 fp=0x1ca2fec sp=0x1ca2fe4 pc=0x314830 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ca2fec sp=0x1ca2fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*http2Transport).newClientConn in goroutine 1037983 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/h2_bundle.go:7879 +0xcb0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: goroutine 968784 gp=0x1afbe68 m=nil [select]: Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.gopark(0x7e4134, 0x0, 0x9, 0x3, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/proc.go:402 +0x104 fp=0x1ca1eb0 sp=0x1ca1e9c pc=0x5d0c0 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.selectgo(0x1ca1fac, 0x1ca1f78, 0x0, 0x0, 0x2, 0x1) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/select.go:327 +0xaf0 fp=0x1ca1f50 sp=0x1ca1eb0 pc=0x70e78 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*persistConn).writeLoop(0x19ba218) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:2444 +0xd0 fp=0x1ca1fe4 sp=0x1ca1f50 pc=0x357c1c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: net/http.(*Transport).dialConn.gowrap3() Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:1800 +0x28 fp=0x1ca1fec sp=0x1ca1fe4 pc=0x354a28 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: runtime.goexit({}) Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/runtime/asm_arm.s:859 +0x4 fp=0x1ca1fec sp=0x1ca1fec pc=0x93d6c Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: created by net/http.(*Transport).dialConn in goroutine 966239 Feb 10 12:42:17 my-volumio-digi go-librespot[1751]: /usr/local/go/src/net/http/transport.go:1800 +0x1444 Feb 10 12:42:17 my-volumio-digi go-librespot[1746]: Aborted Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: Discovery: Getting this device information Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::volumioGetState Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CorePlayQueue::getTrack 17 Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:42:19 my-volumio-digi volumio[1367]: verbose: New Socket.io Connection to 192.168.11.227:3000 from 192.168.11.157 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 10 12:42:19 my-volumio-digi volumio[1367]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 10 12:42:20 my-volumio-digi volumio[1367]: info: Initializing connection to go-librespot Websocket Feb 10 12:42:20 my-volumio-digi volumio[1367]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 10 12:42:20 my-volumio-digi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Feb 10 12:42:20 my-volumio-digi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:20 my-volumio-digi systemd[1]: go-librespot-daemon.service: Consumed 3min 27.439s CPU time. Feb 10 12:42:20 my-volumio-digi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:20 my-volumio-digi go-librespot[10643]: go-librespot daemon starting... Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=info msg="running go-librespot 0.4.0" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=debug msg="app state loaded" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 10 12:42:21 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:21+05:00" level=info msg="zeroconf server listening on port 45699" Feb 10 12:42:22 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:22+05:00" level=debug msg="obtained new client token: AAClcXWmbclNijJyrh2ceQ4vnhegRoeBmxQjkK8mRuIdYhQrTsUUjEvQiU8lsakFAMP/rqUqGSzcF9aDxSOtJ3IxvNhMRJh9OjK32pVL5BAltifS/CS2TAPa0P/XBKZ7gidgv1TzNM6DVdzaqQ0R6FP1ZguLymrcP6DzeLNdpWJ9HHvwDyIDSVyBw1hVQFyBy1VEmJYlzoW1aXsBvfFNQagxDVfyjOYmLaWBP6m6oGwjx8ZGM8SLk3HxhQ==" Feb 10 12:42:22 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:22+05:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Feb 10 12:42:22 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:22+05:00" level=debug msg="connected to ap-gew1.spotify.com:443" Feb 10 12:42:22 my-volumio-digi go-librespot[10644]: time="2026-02-10T12:42:22+05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Feb 10 12:42:22 my-volumio-digi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 10 12:42:22 my-volumio-digi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 12:42:23 my-volumio-digi volumio[1367]: info: Initializing connection to go-librespot Websocket Feb 10 12:42:23 my-volumio-digi volumio[1367]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 10 12:42:25 my-volumio-digi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 2. Feb 10 12:42:25 my-volumio-digi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:25 my-volumio-digi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:25 my-volumio-digi go-librespot[10667]: go-librespot daemon starting... Feb 10 12:42:25 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:25+05:00" level=info msg="running go-librespot 0.4.0" Feb 10 12:42:25 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:25+05:00" level=debug msg="app state loaded" Feb 10 12:42:25 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:25+05:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 10 12:42:26 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:26+05:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Feb 10 12:42:26 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:26+05:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 10 12:42:26 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:26+05:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 10 12:42:26 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:26+05:00" level=info msg="zeroconf server listening on port 33103" Feb 10 12:42:26 my-volumio-digi volumio[1367]: info: Initializing connection to go-librespot Websocket Feb 10 12:42:26 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:26+05:00" level=debug msg="new websocket client" Feb 10 12:42:26 my-volumio-digi volumio[1367]: info: Connection to go-librespot Websocket established Feb 10 12:42:27 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:27+05:00" level=debug msg="obtained new client token: AACvvLGR+1y3aL6X1FY/NNVQCjUTufxTViagFov0GBgE7SmlMIjaCkTRGKRSZAU6x04am1mxjePVAKxjd6m3xU8cBaBJBE2BdRC4iOhgQQTtVNlu4r0iH2+TUkss8/NHMg8hkoE5fFDhEV+8ae+ot6HJUE5V5l6FA7+Iz/oFXJbxhpZPefI7BsRSaECu6lw1iaw0oLsgZsPb3Qv9SUymXOwkBNDEpbtGemxFTLNcFnHfgq8eDEY6SUobK2+8" Feb 10 12:42:27 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:27+05:00" level=warning msg="failed to connect to AP ap-gew1.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.65.9:4070: connect: connection refused" Feb 10 12:42:27 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:27+05:00" level=debug msg="connected to ap-gew1.spotify.com:443" Feb 10 12:42:27 my-volumio-digi go-librespot[10668]: time="2026-02-10T12:42:27+05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Feb 10 12:42:27 my-volumio-digi volumio[1367]: info: Connection to go-librespot Websocket closed Feb 10 12:42:27 my-volumio-digi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 10 12:42:27 my-volumio-digi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 12:42:29 my-volumio-digi volumio[1367]: info: Getting Spotify volume Feb 10 12:42:29 my-volumio-digi volumio[1367]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:29 my-volumio-digi volumio[1367]: Error: connect ECONNREFUSED 127.0.0.1:9879 Feb 10 12:42:29 my-volumio-digi volumio[1367]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Feb 10 12:42:29 my-volumio-digi volumio[1367]: errno: -111, Feb 10 12:42:29 my-volumio-digi volumio[1367]: code: 'ECONNREFUSED', Feb 10 12:42:29 my-volumio-digi volumio[1367]: syscall: 'connect', Feb 10 12:42:29 my-volumio-digi volumio[1367]: address: '127.0.0.1', Feb 10 12:42:29 my-volumio-digi volumio[1367]: port: 9879, Feb 10 12:42:29 my-volumio-digi volumio[1367]: response: undefined Feb 10 12:42:29 my-volumio-digi volumio[1367]: } Feb 10 12:42:29 my-volumio-digi volumio[1367]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:42:30 my-volumio-digi systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Feb 10 12:42:30 my-volumio-digi systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:30 my-volumio-digi systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Feb 10 12:42:30 my-volumio-digi go-librespot[10678]: go-librespot daemon starting... Feb 10 12:42:30 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:30+05:00" level=info msg="running go-librespot 0.4.0" Feb 10 12:42:30 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:30+05:00" level=debug msg="app state loaded" Feb 10 12:42:30 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:30+05:00" level=info msg="api server listening on 127.0.0.1:9879" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=info msg="zeroconf server listening on port 34285" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=debug msg="obtained new client token: AAAE7X2IhvF1sPqq+/VnCihhivi7o3ohPgM8vTZ0SaI+ByZ1N0OrmtnojYW+nZ2g0cLxZF9MStOzMlIZJadi7tLJY53PDVqxDfKsOErES6KlT6WPre3iAFRVCNrkgssGM1vfyzF7bp6CqOFMImfJ3AaUX1XbIhDifEsxw1NPsNTJMxd/5PrUoG5dGql1PyhzrLBwVUKY2TdHdsbKG0JhLxxOnujj41uNxoZCRyuBV/GJN3yQHl6ummuLuymj" Feb 10 12:42:31 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:31+05:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Feb 10 12:42:32 my-volumio-digi go-librespot[10679]: time="2026-02-10T12:42:32+05:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: EOF" Feb 10 12:42:32 my-volumio-digi systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Feb 10 12:42:32 my-volumio-digi systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Feb 10 12:42:32 my-volumio-digi sudo[10712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-10 12:41' Feb 10 12:42:32 my-volumio-digi sudo[10712]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"