Apr 03 13:11:02 volumio systemd-backlight[4162]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:02 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:02 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:02 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:02 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:03 volumio go-librespot[19491]: time="2026-04-03T13:11:03+08:00" level=trace msg="sent dealer ping" Apr 03 13:11:03 volumio go-librespot[19491]: time="2026-04-03T13:11:03+08:00" level=trace msg="received dealer pong" Apr 03 13:11:03 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:03 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:03 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:12 volumio go-librespot[19491]: time="2026-04-03T13:11:12+08:00" level=debug msg="fetched chunk 7/8, size: 524288" uri="spotify:track:3Y4GrXUJbZt4xh61up95ts" Apr 03 13:11:13 volumio systemd-backlight[4200]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:13 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:13 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:13 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:13 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:13 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:18 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:18 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio systemd-backlight[4220]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:23 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:23 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:23 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:25 volumio go-librespot[19491]: time="2026-04-03T13:11:25+08:00" level=debug msg="fetched chunk 8/8, size: 71522" uri="spotify:track:3Y4GrXUJbZt4xh61up95ts" Apr 03 13:11:28 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:28 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:28 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:32 volumio go-librespot[19491]: time="2026-04-03T13:11:32+08:00" level=trace msg="received accesspoint ping" Apr 03 13:11:32 volumio go-librespot[19491]: time="2026-04-03T13:11:32+08:00" level=trace msg="received accesspoint pong ack" Apr 03 13:11:33 volumio go-librespot[19491]: time="2026-04-03T13:11:33+08:00" level=trace msg="sent dealer ping" Apr 03 13:11:33 volumio go-librespot[19491]: time="2026-04-03T13:11:33+08:00" level=trace msg="received dealer pong" Apr 03 13:11:33 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:34 volumio systemd-backlight[4239]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:34 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:34 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:34 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:34 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:38 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="prefetching next track" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="selected format OGG_VORBIS_320 (b3ccdcbc40671c0081acd3f1122e5795b74583c5)" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="requested aes key for file b3ccdcbc40671c0081acd3f1122e5795b74583c5, gid: 2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=trace msg="found 2 cdn urls" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="fetched first chunk of 8, total size is 3740994 bytes" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=info msg="prefetched track \"Fingertips on Ivory\" (duration: 93133ms)" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="fetched chunk 3/7, size: 524288" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:39 volumio go-librespot[19491]: time="2026-04-03T13:11:39+08:00" level=debug msg="fetched chunk 1/7, size: 524288" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:40 volumio go-librespot[19491]: time="2026-04-03T13:11:40+08:00" level=debug msg="fetched chunk 2/7, size: 524288" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:11:43 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:43 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:44 volumio systemd-backlight[4258]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:44 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:44 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:44 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:44 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:48 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:49 volumio volumio[1412]: error: [now-playing] Error fetching OpenWeatherMap resource "https://api.openweathermap.org/data/3.0/onecall?appid=5e70af3777de85ada0effbf026b04fe5&lat=2.9076039246526992&lon=112.08643213183304&units=metric": Response error: 401 - Unauthorized Apr 03 13:11:49 volumio volumio[1412]: error: [now-playing] Caught error in callback of WeatherAPI.#getFetchPromise(): Response error: 401 - Unauthorized Apr 03 13:11:49 volumio volumio[1412]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not fetch weather: Response error: 401 - Unauthorized Apr 03 13:11:49 volumio volumio[1412]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:108:25) Apr 03 13:11:49 volumio volumio[1412]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Apr 03 13:11:49 volumio volumio[1412]: at async Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:126:28) Apr 03 13:11:53 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:53 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:55 volumio systemd-backlight[4276]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:11:55 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:11:55 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:11:55 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:11:55 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:11:58 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:58 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:58 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:58 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:11:58 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:03 volumio go-librespot[19491]: time="2026-04-03T13:12:03+08:00" level=trace msg="sent dealer ping" Apr 03 13:12:03 volumio go-librespot[19491]: time="2026-04-03T13:12:03+08:00" level=trace msg="received dealer pong" Apr 03 13:12:03 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:03 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:05 volumio systemd-backlight[4295]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:12:05 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:12:05 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:12:05 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:12:05 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:12:07 volumio go-librespot[19491]: time="2026-04-03T13:12:07+08:00" level=trace msg="emitting websocket event: not_playing" Apr 03 13:12:07 volumio go-librespot[19491]: time="2026-04-03T13:12:07+08:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:12:07 volumio volumio[1412]: SPOTIFY: received: {"type":"not_playing","data":{"context_uri":"spotify:station:playlist:6pmKqRDS6giOr74fD281bk","uri":"spotify:track:3Y4GrXUJbZt4xh61up95ts","play_origin":"home"}} Apr 03 13:12:07 volumio volumio[1412]: error: Failed to decode event: not_playing Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=trace msg="emitting websocket event: will_play" Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=info msg="loaded track \"Fingertips on Ivory\" (paused: false, position: 1ms, duration: 93133ms, prefetched: true)" uri="spotify:track:2Fo5X3OL84UCVfIAEqxtmH" Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:station:playlist:6pmKqRDS6giOr74fD281bk","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","play_origin":"home"}} Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=trace msg="scheduling prefetch in 63s" Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=trace msg="emitting websocket event: metadata" Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","name":"Fingertips on Ivory","artist_names":["Vivienne Noir"],"album_name":"Piano Affairs","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02c6ad606da43cb3b45d02c5c8","position":1,"duration":93133,"release_date":"year:2025 month:2 day:14","track_number":3,"disc_number":1}} Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 03 13:12:08 volumio go-librespot[19491]: time="2026-04-03T13:12:08+08:00" level=trace msg="emitting websocket event: playing" Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:station:playlist:6pmKqRDS6giOr74fD281bk","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","resume":false,"play_origin":"home"}} Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: PUSH STATE SPOTIFY Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: {"status":"play","service":"spop","title":"Fingertips on Ivory","artist":"Vivienne Noir","album":"Piano Affairs","albumart":"https://i.scdn.co/image/ab67616d00001e02c6ad606da43cb3b45d02c5c8","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","trackType":"spotify","seek":1,"duration":93,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::servicePushState Apr 03 13:12:08 volumio volumio[1412]: info: CoreStateMachine::pushState Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::volumioPushState Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:12:08 volumio volumio[1412]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"Fingertips on Ivory","artist":"Vivienne Noir","album":"Piano Affairs","duration":"93","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","service":""} Apr 03 13:12:08 volumio volumio[1412]: info: [now-playing] LRCLIB getLyrics(): song: "Fingertips on Ivory" album: "Piano Affairs" artist: "Vivienne Noir" duration: "93" Apr 03 13:12:08 volumio volumio[1412]: info: [now-playing] LRCLIB getLyrics() API URL: https://lrclib.net/api/get?track_name=Fingertips+on+Ivory&artist_name=Vivienne+Noir&album_name=Piano+Affairs&duration=93 Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 03 13:12:08 volumio volumio[1412]: info: [now-playing] Fetch metadata (DefaultMetadataProvider): {"type":"song","name":"Fingertips on Ivory","artist":"Vivienne Noir","album":"Piano Affairs","duration":"93","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","service":""} Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: PUSH STATE SPOTIFY Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: {"status":"play","service":"spop","title":"Fingertips on Ivory","artist":"Vivienne Noir","album":"Piano Affairs","albumart":"https://i.scdn.co/image/ab67616d00001e02c6ad606da43cb3b45d02c5c8","uri":"spotify:track:2Fo5X3OL84UCVfIAEqxtmH","trackType":"spotify","seek":1,"duration":93,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"} Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::servicePushState Apr 03 13:12:08 volumio volumio[1412]: info: CoreStateMachine::pushState Apr 03 13:12:08 volumio volumio[1412]: info: CoreCommandRouter::volumioPushState Apr 03 13:12:08 volumio volumio[1412]: SPOTIFY: RECEIVED VOLUMIO VOLUME 46 Apr 03 13:12:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:08 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:09 volumio volumio[1412]: error: [now-playing] Error fetching lyrics from LRCLIB (URL: https://lrclib.net/api/get?track_name=Fingertips+on+Ivory&artist_name=Vivienne+Noir&album_name=Piano+Affairs&duration=93): Error: Response error: 404 - Not Found Apr 03 13:12:09 volumio volumio[1412]: at apiGet (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:20:15) Apr 03 13:12:09 volumio volumio[1412]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Apr 03 13:12:09 volumio volumio[1412]: at async LRCLibAPI.getLyrics (/data/plugins/user_interface/now_playing/dist/lib/api/lrclib/index.js:33:24) Apr 03 13:12:09 volumio volumio[1412]: at async DefaultMetadataProvider.getSongInfo (/data/plugins/user_interface/now_playing/dist/lib/api/DefaultMetadataProvider.js:72:37) Apr 03 13:12:09 volumio volumio[1412]: at async /data/plugins/user_interface/now_playing/dist/lib/api/MetadataAPI.js:135:40 Apr 03 13:12:13 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:16 volumio systemd-backlight[4313]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:12:16 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:12:16 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:12:16 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:12:16 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:12:18 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:18 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=info msg="playback was transferred to MiniAudio" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=trace msg="closed output device because of stop command" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1166" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 415" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="put connect state inactive" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=trace msg="emitting websocket event: inactive" Apr 03 13:12:19 volumio volumio[1412]: SPOTIFY: received: {"type":"inactive","data":null} Apr 03 13:12:19 volumio volumio[1412]: error: Failed to decode event: inactive Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="dealer connection closed" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="dealer recv loop stopped" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="obtained new client token: AAA3L1dazO0nNVdI5JujP2eg63tm94RZj633HGopojTIzPZ0uaEtREVyBBZDZkbPnEY1lmQq/3CqR/F7Q9/gjWP8DxX77gucz64uSUG+7A63PRGiFakdvBNB7gMvRqEFwkzccXfF8AyZqXEWptqR0tZPcuW0MX5dQLADXk3ZbTFipDl6gg0hRxJbXSBjc2MjPqalNyTzJP8TJRWGO7whXIKoN31DxB7yrqZbxF0Y4N6yZnmZvhpIEoNl" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="completed keyexchange" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=debug msg="completed challenge" Apr 03 13:12:19 volumio go-librespot[19491]: time="2026-04-03T13:12:19+08:00" level=info msg="authenticated AP" username="31************************su" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=info msg="authenticated Login5" username="31************************su" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="restored session after logout" username="31************************su" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="dealer connection opened" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=trace msg="starting accesspoint recv loop" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=trace msg="starting dealer recv loop" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=trace msg="received accesspoint ping" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="received connection id: ZmI4YjNjYjEtNTk5...MTdBNjNERjM3OQ==" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=trace msg="received accesspoint pong ack" Apr 03 13:12:20 volumio go-librespot[19491]: time="2026-04-03T13:12:20+08:00" level=debug msg="put connect state because NEW_DEVICE" Apr 03 13:12:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:23 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:26 volumio systemd-backlight[4330]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:12:26 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:12:26 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:12:26 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:12:26 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:12:28 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:34 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:34 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:34 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:37 volumio systemd-backlight[4347]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:12:37 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:12:37 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:12:37 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:12:37 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:12:39 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:39 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:39 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:44 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:44 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:44 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:46 volumio go-librespot[19491]: time="2026-04-03T13:12:46+08:00" level=debug msg="handling transfer player command from df977d0304723efd3dd7d95be7dfe0fc55726554" Apr 03 13:12:46 volumio go-librespot[19491]: time="2026-04-03T13:12:46+08:00" level=debug msg="resolved context of track" uri="spotify:station:playlist:6pmKqRDS6giOr74fD281bk" Apr 03 13:12:46 volumio go-librespot[19491]: panic: runtime error: invalid memory address or nil pointer dereference Apr 03 13:12:46 volumio go-librespot[19491]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x49b308] Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117939 gp=0x1a2eb48 m=3 mp=0x184d008 [running]: Apr 03 13:12:46 volumio go-librespot[19491]: panic({0x841d88, 0xfa0250}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x1a896d4 sp=0x1a89680 pc=0xa92ec Apr 03 13:12:46 volumio go-librespot[19491]: runtime.panicmem(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/panic.go:262 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.sigpanic() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x1a89704 sp=0x1a896d4 pc=0xabca4 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot.ContextTrackToProvidedTrack({0x919ccb, 0x5}, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /src/ids.go:25 +0x14 fp=0x1a89768 sp=0x1a89708 pc=0x49b308 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*AppPlayer).handlePlayerCommand(0x1b62780, {0xa3da8c, 0x1b63040}, {0x51c215ac, {0x1b70d80, 0x28}, {{0x1b21200, 0x8}, {0x0, 0x0}, ...}}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/player.go:202 +0x1858 fp=0x1a8989c sp=0x1a89768 pc=0x6c1e68 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*AppPlayer).handleDealerRequest(0x1b62780, {0xa3da1c, 0x1005090}, {0x1b0c4c0, {0x1b70d20, 0x24}, {0x51c215ac, {0x1b70d80, 0x28}, {{0x1b21200, ...}, ...}}}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/player.go:367 +0x194 fp=0x1a899e0 sp=0x1a8989c pc=0x6c2ae0 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*AppPlayer).Run(0x1b62780, {0xa3da1c, 0x1005090}, 0x1b0cb80, 0x1b0cbc0) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/player.go:685 +0x638 fp=0x1a89fd4 sp=0x1a899e0 pc=0x6c5c20 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).withAppPlayer.func2.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:328 +0x48 fp=0x1a89fec sp=0x1a89fd4 pc=0x6bd884 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a89fec sp=0x1a89fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by main.(*App).withAppPlayer.func2 in goroutine 84 Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:328 +0x2f0 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 1 gp=0x1802128 m=nil [select, 969 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x185cce0 sp=0x185cccc pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.selectgo(0x185cdf0, 0x19abdbc, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x185cd90 sp=0x185cce0 pc=0x85000 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x1b52000, 0x185ce90) Apr 03 13:12:46 volumio go-librespot[19491]: /src/zeroconf/zeroconf.go:300 +0x228 fp=0x185ce38 sp=0x185cd90 pc=0x62f43c Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).withAppPlayer(0x18ce880, {0xa3da1c, 0x1005090}, 0x18ad8d0) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:340 +0x5dc fp=0x185ced0 sp=0x185ce38 pc=0x6bcc60 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).withCredentials(...) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:209 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).SpotifyToken(0x18ce880, {0xa3da1c, 0x1005090}, {0x18ca9c0, 0x1c}, {0x18a03c0, 0x13e}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x185cf00 sp=0x185ced0 pc=0x6bc02c Apr 03 13:12:46 volumio go-librespot[19491]: main.main() Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:620 +0x660 fp=0x185cfa8 sp=0x185cf00 pc=0x6bf56c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.main() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x185cfec sp=0x185cfa8 pc=0x6f390 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x185cfec sp=0x185cfec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 2 gp=0x18027e8 m=nil [force gc (idle), 5 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97746c, 0xff8fa8, 0x11, 0xa, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1848fd4 sp=0x1848fc0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goparkunlock(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.forcegchelper() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x1848fec sp=0x1848fd4 pc=0x6f7f4 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1848fec sp=0x1848fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.init.6 in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:361 +0x1c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 3 gp=0x1802b48 m=nil [GC sweep wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97746c, 0xff9850, 0xc, 0x9, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18497c4 sp=0x18497b0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goparkunlock(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.bgsweep(0x182e050) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x18497e4 sp=0x18497c4 pc=0x5768c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcenable.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x18497ec sp=0x18497e4 pc=0x46c3c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18497ec sp=0x18497ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcenable in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 4 gp=0x1802c68 m=nil [GC scavenge wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97746c, 0xffa170, 0xd, 0xa, 0x2) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1849fb4 sp=0x1849fa0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goparkunlock(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.(*scavengerState).park(0xffa170) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1849fc8 sp=0x1849fb4 pc=0x54a28 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.bgscavenge(0x182e050) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1849fe4 sp=0x1849fc8 pc=0x5516c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcenable.gowrap2() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x1849fec sp=0x1849fe4 pc=0x46be8 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1849fec sp=0x1849fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcenable in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 18 gp=0x1882248 m=nil [GOMAXPROCS updater (idle), 969 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97746c, 0xff95e8, 0x12, 0xa, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18447a4 sp=0x1844790 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goparkunlock(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.updateMaxProcsGoroutine() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x18447ec sp=0x18447a4 pc=0x7f174 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18447ec sp=0x18447ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 19 gp=0x18825a8 m=nil [finalizer wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x977314, 0x1005180, 0x10, 0xa, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1844f88 sp=0x1844f74 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.runFinalizers() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x1844fec sp=0x1844f88 pc=0x45888 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1844fec sp=0x1844fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.createfing in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 20 gp=0x1969b08 m=nil [cleanup wait, 73 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97746c, 0xffa348, 0x2e, 0xa, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18487a4 sp=0x1848790 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goparkunlock(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.(*cleanupQueue).dequeue(0xffa2e8) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x18487c4 sp=0x18487a4 pc=0x41cb0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.runCleanups() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x18487ec sp=0x18487c4 pc=0x4284c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18487ec sp=0x18487ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 23 gp=0x199cd88 m=nil [IO wait, 1 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb614a010, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a12cf0 sp=0x1a12cdc pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb614a000, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1a12d08 sp=0x1a12cf0 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb614a000, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1a12d1c sp=0x1a12d08 pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x18a5468, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1a12d30 sp=0x1a12d1c pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Accept(0x18a5450) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1a12d78 sp=0x1a12d30 pc=0x13a800 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).accept(0x18a5450) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1a12de0 sp=0x1a12d78 pc=0x1abc28 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*TCPListener).accept(0x18b0600) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1a12e34 sp=0x1a12de0 pc=0x1c3554 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*TCPListener).Accept(0x18b0600) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1a12e50 sp=0x1a12e34 pc=0x1c259c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*onceCloseListener).Accept(0x1a1c080) Apr 03 13:12:46 volumio go-librespot[19491]: :1 +0x34 fp=0x1a12e68 sp=0x1a12e50 pc=0x367f9c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*Server).Serve(0x1a2c008, {0xa3d218, 0x18b0600}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1a12f00 sp=0x1a12e68 pc=0x341154 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.Serve(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2971 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*ConcreteApiServer).serve(0x189e840) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x1a12fe4 sp=0x1a12f00 pc=0x6b17bc Apr 03 13:12:46 volumio go-librespot[19491]: main.NewApiServer.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x1a12fec sp=0x1a12fe4 pc=0x6b04f4 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a12fec sp=0x1a12fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by main.NewApiServer in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/api_server.go:332 +0x310 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 37 gp=0x199d208 m=nil [GC worker (idle)]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x977320, 0x1ac2800, 0x1c, 0xa, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1aa0f88 sp=0x1aa0f74 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkWorker(0x1c3c500) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1aa0fe4 sp=0x1aa0f88 pc=0x49f34 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1aa0fec sp=0x1aa0fe4 pc=0x49e14 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1aa0fec sp=0x1aa0fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 38 gp=0x1a2e368 m=nil [GC worker (idle)]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x977320, 0x1ac2a00, 0x1c, 0xa, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a0ff88 sp=0x1a0ff74 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkWorker(0x1c3c500) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1a0ffe4 sp=0x1a0ff88 pc=0x49f34 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1a0ffec sp=0x1a0ffe4 pc=0x49e14 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a0ffec sp=0x1a0ffec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 39 gp=0x1a2e488 m=nil [GC worker (idle)]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x977320, 0x1ac2c00, 0x1c, 0xa, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1d97788 sp=0x1d97774 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkWorker(0x1c3c500) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1d977e4 sp=0x1d97788 pc=0x49f34 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1d977ec sp=0x1d977e4 pc=0x49e14 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1d977ec sp=0x1d977ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 40 gp=0x1a2e5a8 m=nil [GC worker (idle)]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x977320, 0x1ac2e00, 0x1c, 0xa, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1e73f88 sp=0x1e73f74 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkWorker(0x1c3c500) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1e73fe4 sp=0x1e73f88 pc=0x49f34 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1e73fec sp=0x1e73fe4 pc=0x49e14 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1e73fec sp=0x1e73fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by runtime.gcBgMarkStartWorkers in goroutine 35 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 41 gp=0x1802fc8 m=nil [chan receive, 969 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9772f4, 0x1b0d2b8, 0xe, 0x7, 0x2) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1845f78 sp=0x1845f64 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv(0x1b0d280, 0x0, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1845fc0 sp=0x1845f78 pc=0x3414c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv1(0x1b0d280, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x1845fd4 sp=0x1845fc0 pc=0x33bcc Apr 03 13:12:46 volumio go-librespot[19491]: github.com/godbus/dbus/v5.newConn.func1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:303 +0x40 fp=0x1845fec sp=0x1845fd4 pc=0x4aa8ec Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1845fec sp=0x1845fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/godbus/dbus/v5.newConn in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:302 +0x52c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 42 gp=0x18030e8 m=nil [IO wait, 969 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb6149a10, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1856cbc sp=0x1856ca8 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb6149a00, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1856cd4 sp=0x1856cbc pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb6149a00, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1856ce8 sp=0x1856cd4 pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x1b1e0b8, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1856cfc sp=0x1856ce8 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).ReadMsg(0x1b1e0a0, {0x1b20cf0, 0x10, 0x10}, {0x1b77318, 0x1000, 0x1000}, 0x40000000) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:295 +0x2c0 fp=0x1856d6c sp=0x1856cfc pc=0x1381bc Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).readMsg(0x1b1e0a0, {0x1b20cf0, 0x10, 0x10}, {0x1b77318, 0x1000, 0x1000}, 0x40000000) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:91 +0x58 fp=0x1856dc8 sp=0x1856d6c pc=0x1aa2c8 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*UnixConn).readMsg(0x1b241a8, {0x1b20cf0, 0x10, 0x10}, {0x1b77318, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/unixsock_posix.go:115 +0x58 fp=0x1856e28 sp=0x1856dc8 pc=0x1c9d80 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*UnixConn).ReadMsgUnix(0x1b241a8, {0x1b20cf0, 0x10, 0x10}, {0x1b77318, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/unixsock.go:143 +0x58 fp=0x1856e78 sp=0x1856e28 pc=0x1c820c Apr 03 13:12:46 volumio go-librespot[19491]: github.com/godbus/dbus/v5.(*oobReader).Read(0x1b77308, {0x1b20cf0, 0x10, 0x10}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:41 +0x50 fp=0x1856ec8 sp=0x1856e78 pc=0x4c2af0 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa39d58, 0x1b77308}, {0x1b20cf0, 0x10, 0x10}, 0x10) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1856ef4 sp=0x1856ec8 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/godbus/dbus/v5.(*unixTransport).ReadMessage(0x1b28130) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:124 +0x224 fp=0x1856fa0 sp=0x1856ef4 pc=0x4c32c4 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/godbus/dbus/v5.(*Conn).inWorker(0x1a00200) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:390 +0x44 fp=0x1856fe4 sp=0x1856fa0 pc=0x4aaef4 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/godbus/dbus/v5.(*Conn).Auth.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x28 fp=0x1856fec sp=0x1856fe4 pc=0x4a8318 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1856fec sp=0x1856fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/godbus/dbus/v5.(*Conn).Auth in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x77c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 83 gp=0x1a2ed88 m=nil [chan receive, 1 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9772f4, 0x1890238, 0xe, 0x7, 0x2) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a36f3c sp=0x1a36f28 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv(0x1890200, 0x1a36fd0, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1a36f84 sp=0x1a36f3c pc=0x3414c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv2(0x1890200, 0x1a36fd0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x1a36f98 sp=0x1a36f84 pc=0x33bf0 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).withAppPlayer.func1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:284 +0x68 fp=0x1a36fec sp=0x1a36f98 pc=0x6bd918 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a36fec sp=0x1a36fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:281 +0x4f8 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 84 gp=0x1a2eea8 m=nil [chan receive]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9772f4, 0x18901f8, 0xe, 0x7, 0x2) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1baef40 sp=0x1baef2c pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv(0x18901c0, 0x1a81fe0, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1baef88 sp=0x1baef40 pc=0x3414c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv2(0x18901c0, 0x1a81fe0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x1baef9c sp=0x1baef88 pc=0x33bf0 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*App).withAppPlayer.func2() Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:300 +0x6c fp=0x1baefec sp=0x1baef9c pc=0x6bd47c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1baefec sp=0x1baefec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/main.go:297 +0x598 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 85 gp=0x1a2efc8 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb6149c10, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a37dac sp=0x1a37d98 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb6149c00, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1a37dc4 sp=0x1a37dac pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb6149c00, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1a37dd8 sp=0x1a37dc4 pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x1b1e068, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1a37dec sp=0x1a37dd8 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Accept(0x1b1e050) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1a37e34 sp=0x1a37dec pc=0x13a800 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).accept(0x1b1e050) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1a37e9c sp=0x1a37e34 pc=0x1abc28 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*TCPListener).accept(0x1b06060) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1a37ef0 sp=0x1a37e9c pc=0x1c3554 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*TCPListener).Accept(0x1b06060) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1a37f0c sp=0x1a37ef0 pc=0x1c259c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*onceCloseListener).Accept(0x1c14cc0) Apr 03 13:12:46 volumio go-librespot[19491]: :1 +0x34 fp=0x1a37f24 sp=0x1a37f0c pc=0x367f9c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*Server).Serve(0x1a549a8, {0xa3d218, 0x1b06060}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1a37fbc sp=0x1a37f24 pc=0x341154 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.Serve(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2971 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Apr 03 13:12:46 volumio go-librespot[19491]: /src/zeroconf/zeroconf.go:297 +0x8c fp=0x1a37fec sp=0x1a37fbc pc=0x62f538 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a37fec sp=0x1a37fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Apr 03 13:12:46 volumio go-librespot[19491]: /src/zeroconf/zeroconf.go:297 +0x160 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 71 gp=0x199c488 m=nil [IO wait, 969 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb579de10, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a85908 sp=0x1a858f4 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb579de00, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1a85920 sp=0x1a85908 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb579de00, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1a85934 sp=0x1a85920 pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x19e2018, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1a85948 sp=0x1a85934 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x19e2000, {0x19a8000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1a85990 sp=0x1a85948 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x19e2000, {0x19a8000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1a859bc sp=0x1a85990 pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x1832050, {0x19a8000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1a859e8 sp=0x1a859bc pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: io.(*multiReader).Read(0x1b28050, {0x19a8000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x1a85a14 sp=0x1a859e8 pc=0xefb88 Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).fill(0x1800090) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x1a85a38 sp=0x1a85a14 pc=0x2b6c1c Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).ReadByte(0x1800090) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x1a85a44 sp=0x1a85a38 pc=0x2b7498 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.readFrameHeader(0x1800090, {0x190adb8, 0x8, 0x8}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x1a85a84 sp=0x1a85a44 pc=0x372a08 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.(*Conn).readFrameHeader(0x190ad88, {0xa3da00, 0x1005090}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x1a85b08 sp=0x1a85a84 pc=0x375bd4 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.(*Conn).readLoop(0x190ad88, {0xa3da00, 0x1005090}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x1a85bcc sp=0x1a85b08 pc=0x375390 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.(*Conn).reader(0x190ad88, {0xa3da00, 0x1005090}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x1a85c50 sp=0x1a85bcc pc=0x376798 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.(*Conn).Reader(...) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/coder/websocket.(*Conn).Read(0x190ad88, {0xa3da00, 0x1005090}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x1a85c78 sp=0x1a85c50 pc=0x374944 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*ConcreteApiServer).serve.func17({0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /src/cmd/daemon/api_server.go:636 +0x3b4 fp=0x1a85cfc sp=0x1a85c78 pc=0x6b2040 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.HandlerFunc.ServeHTTP(0x1a08188, {0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1a85d0c sp=0x1a85cfc pc=0x33d7d8 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*ServeMux).ServeHTTP(0x1a00000, {0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x1a85d4c sp=0x1a85d0c pc=0x33f6c8 Apr 03 13:12:46 volumio go-librespot[19491]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x1a85d74 sp=0x1a85d4c pc=0x6b19b8 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.HandlerFunc.ServeHTTP(0x1a04140, {0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1a85d84 sp=0x1a85d74 pc=0x33d7d8 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.serverHandler.ServeHTTP({0x1a2c008}, {0xa3d2d8, 0x1a54168}, 0x1a54008) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x1a85da0 sp=0x1a85d84 pc=0x35cb44 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*conn).serve(0x1b520c0, {0xa3da38, 0x1a1a1e0}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x1a85fdc sp=0x1a85da0 pc=0x33b894 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*Server).Serve.gowrap3() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x1a85fec sp=0x1a85fdc pc=0x3415cc Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a85fec sp=0x1a85fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*Server).Serve in goroutine 23 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/server.go:3493 +0x42c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7103132 gp=0x199dc28 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb579da10, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1a15af4 sp=0x1a15ae0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb579da00, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1a15b0c sp=0x1a15af4 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb579da00, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1a15b20 sp=0x1a15b0c pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x19d0ce8, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1a15b34 sp=0x1a15b20 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x19d0cd0, {0x1c9e000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1a15b7c sp=0x1a15b34 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x19d0cd0, {0x1c9e000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1a15ba8 sp=0x1a15b7c pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x189c4f0, {0x1c9e000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1a15bd4 sp=0x1a15ba8 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*atLeastReader).Read(0x18add60, {0x1c9e000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1a15c00 sp=0x1a15bd4 pc=0x2674c0 Apr 03 13:12:46 volumio go-librespot[19491]: bytes.(*Buffer).ReadFrom(0x1c7818c, {0xa3a068, 0x18add60}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1a15c3c sp=0x1a15c00 pc=0x162058 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readFromUntil(0x1c78008, {0xa38fa8, 0x189c4f0}, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1a15c64 sp=0x1a15c3c pc=0x26771c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecordOrCCS(0x1c78008, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1a15dc4 sp=0x1a15c64 pc=0x264e40 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).Read(0x1c78008, {0x1913000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1a15df4 sp=0x1a15dc4 pc=0x26ac04 Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).Read(0x19ee300, {0x1ba0224, 0x9, 0x9}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1a15e18 sp=0x1a15df4 pc=0x2b72a0 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa391f8, 0x19ee300}, {0x1ba0224, 0x9, 0x9}, 0x9) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1a15e44 sp=0x1a15e18 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.http2readFrameHeader({0x1ba0224, 0x9, 0x9}, {0xa391f8, 0x19ee300}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1a15e6c sp=0x1a15e44 pc=0x2f86ac Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Framer).ReadFrame(0x1ba0200) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1a15ef4 sp=0x1a15e6c pc=0x2f8e04 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2clientConnReadLoop).run(0x1a15fdc) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1a15fa4 sp=0x1a15ef4 pc=0x31d33c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2ClientConn).readLoop(0x197e368) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1a15fe4 sp=0x1a15fa4 pc=0x31c604 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1a15fec sp=0x1a15fe4 pc=0x316960 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1a15fec sp=0x1a15fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*http2Transport).newClientConn in goroutine 7103131 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117925 gp=0x1cb97a8 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb6149610, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1857af4 sp=0x1857ae0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb6149600, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1857b0c sp=0x1857af4 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb6149600, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1857b20 sp=0x1857b0c pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x1b629c8, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1857b34 sp=0x1857b20 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x1b629b0, {0x1ff5000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1857b7c sp=0x1857b34 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x1b629b0, {0x1ff5000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1857ba8 sp=0x1857b7c pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x189c058, {0x1ff5000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1857bd4 sp=0x1857ba8 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*atLeastReader).Read(0x1c12660, {0x1ff5000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1857c00 sp=0x1857bd4 pc=0x2674c0 Apr 03 13:12:46 volumio go-librespot[19491]: bytes.(*Buffer).ReadFrom(0x1c78ccc, {0xa3a068, 0x1c12660}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1857c3c sp=0x1857c00 pc=0x162058 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readFromUntil(0x1c78b48, {0xa38fa8, 0x189c058}, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1857c64 sp=0x1857c3c pc=0x26771c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecordOrCCS(0x1c78b48, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1857dc4 sp=0x1857c64 pc=0x264e40 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).Read(0x1c78b48, {0x1ac9000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1857df4 sp=0x1857dc4 pc=0x26ac04 Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).Read(0x1b07140, {0x1a000a4, 0x9, 0x9}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1857e18 sp=0x1857df4 pc=0x2b72a0 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa391f8, 0x1b07140}, {0x1a000a4, 0x9, 0x9}, 0x9) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1857e44 sp=0x1857e18 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.http2readFrameHeader({0x1a000a4, 0x9, 0x9}, {0xa391f8, 0x1b07140}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1857e6c sp=0x1857e44 pc=0x2f86ac Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Framer).ReadFrame(0x1a00080) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1857ef4 sp=0x1857e6c pc=0x2f8e04 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2clientConnReadLoop).run(0x1857fdc) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1857fa4 sp=0x1857ef4 pc=0x31d33c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2ClientConn).readLoop(0x26fd328) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1857fe4 sp=0x1857fa4 pc=0x31c604 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1857fec sp=0x1857fe4 pc=0x316960 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1857fec sp=0x1857fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*http2Transport).newClientConn in goroutine 7117924 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117664 gp=0x1d00d88 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb6149810, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1baaaf4 sp=0x1baaae0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb6149800, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1baab0c sp=0x1baaaf4 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb6149800, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1baab20 sp=0x1baab0c pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x1b62b58, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1baab34 sp=0x1baab20 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x1b62b40, {0x1d12000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1baab7c sp=0x1baab34 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x1b62b40, {0x1d12000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1baaba8 sp=0x1baab7c pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x1a08f28, {0x1d12000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1baabd4 sp=0x1baaba8 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*atLeastReader).Read(0x1a04c80, {0x1d12000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1baac00 sp=0x1baabd4 pc=0x2674c0 Apr 03 13:12:46 volumio go-librespot[19491]: bytes.(*Buffer).ReadFrom(0x18c75cc, {0xa3a068, 0x1a04c80}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1baac3c sp=0x1baac00 pc=0x162058 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readFromUntil(0x18c7448, {0xa38fa8, 0x1a08f28}, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1baac64 sp=0x1baac3c pc=0x26771c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecordOrCCS(0x18c7448, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1baadc4 sp=0x1baac64 pc=0x264e40 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).Read(0x18c7448, {0x1d34000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1baadf4 sp=0x1baadc4 pc=0x26ac04 Apr 03 13:12:46 volumio volumio[1412]: info: Connection to go-librespot Websocket closed Apr 03 13:12:46 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).Read(0x19ee000, {0x1a485a4, 0x9, 0x9}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1baae18 sp=0x1baadf4 pc=0x2b72a0 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa391f8, 0x19ee000}, {0x1a485a4, 0x9, 0x9}, 0x9) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1baae44 sp=0x1baae18 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.http2readFrameHeader({0x1a485a4, 0x9, 0x9}, {0xa391f8, 0x19ee000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1baae6c sp=0x1baae44 pc=0x2f86ac Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Framer).ReadFrame(0x1a48580) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1baaef4 sp=0x1baae6c pc=0x2f8e04 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2clientConnReadLoop).run(0x1baafdc) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1baafa4 sp=0x1baaef4 pc=0x31d33c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2ClientConn).readLoop(0x2280248) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1baafe4 sp=0x1baafa4 pc=0x31c604 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1baafec sp=0x1baafe4 pc=0x316960 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1baafec sp=0x1baafec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*http2Transport).newClientConn in goroutine 7117663 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117376 gp=0x197e128 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb579dc10, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1bacd04 sp=0x1baccf0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb579dc00, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1bacd1c sp=0x1bacd04 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb579dc00, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1bacd30 sp=0x1bacd1c pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x26cc0b8, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1bacd44 sp=0x1bacd30 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x26cc0a0, {0x1813d70, 0x3, 0x3}) Apr 03 13:12:46 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1bacd8c sp=0x1bacd44 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x26cc0a0, {0x1813d70, 0x3, 0x3}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1bacdb8 sp=0x1bacd8c pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x1b8c000, {0x1813d70, 0x3, 0x3}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1bacde4 sp=0x1bacdb8 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa38fa8, 0x1b8c000}, {0x1813d70, 0x3, 0x3}, 0x3) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1bace10 sp=0x1bacde4 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x1c3ed00, {0xa3da1c, 0x1005090}) Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/shannon.go:124 +0x370 fp=0x1baced4 sp=0x1bace10 pc=0x4fac0c Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1b08378) Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:289 +0x68 fp=0x1bacfe4 sp=0x1baced4 pc=0x4f74ac Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:273 +0x28 fp=0x1bacfec sp=0x1bacfe4 pc=0x4f7418 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1bacfec sp=0x1bacfec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 7117939 Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:273 +0x98 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117954 gp=0x1bf2128 m=nil [chan receive]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9772f4, 0x1b0c4f8, 0xe, 0x7, 0x2) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ba9d44 sp=0x1ba9d30 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv(0x1b0c4c0, 0x1ba9dcb, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1ba9d8c sp=0x1ba9d44 pc=0x3414c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.chanrecv1(0x1b0c4c0, 0x1ba9dcb) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x1ba9da0 sp=0x1ba9d8c pc=0x33bcc Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x1a2cd18, 0x1b62e10) Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/recv.go:237 +0x1f8 fp=0x1ba9f1c sp=0x1ba9da0 pc=0x5a3fa0 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1a2cd18) Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:213 +0x4d0 fp=0x1ba9fe4 sp=0x1ba9f1c pc=0x5a26a4 Apr 03 13:12:46 volumio systemd[1]: go-librespot-daemon.service: Consumed 20min 11.061s CPU time. Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:125 +0x28 fp=0x1ba9fec sp=0x1ba9fe4 pc=0x5a3d28 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ba9fec sp=0x1ba9fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 7117939 Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:125 +0x98 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117377 gp=0x2b47688 m=nil [select]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1d9bea4 sp=0x1d9be90 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.selectgo(0x1d9bfd4, 0x1d9bf78, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1d9bf54 sp=0x1d9bea4 pc=0x85000 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x1b08378) Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:368 +0x8c fp=0x1d9bfe4 sp=0x1d9bf54 pc=0x4f7cf8 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:277 +0x28 fp=0x1d9bfec sp=0x1d9bfe4 pc=0x4f73c4 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1d9bfec sp=0x1d9bfec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 7117939 Apr 03 13:12:46 volumio go-librespot[19491]: /src/ap/ap.go:277 +0x15c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7103155 gp=0x19aac68 m=nil [select, 1 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x185dea0 sp=0x185de8c pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.selectgo(0x185dfac, 0x185df78, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x185df50 sp=0x185dea0 pc=0x85000 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*persistConn).writeLoop(0x1a2cfd8) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:2600 +0xc0 fp=0x185dfe4 sp=0x185df50 pc=0x358240 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*Transport).dialConn.gowrap3() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:1948 +0x28 fp=0x185dfec sp=0x185dfe4 pc=0x3552f8 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x185dfec sp=0x185dfec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*Transport).dialConn in goroutine 7103146 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:1948 +0x175c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117672 gp=0x19ad568 m=nil [IO wait]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb6149210, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ba8af4 sp=0x1ba8ae0 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb6149200, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1ba8b0c sp=0x1ba8af4 pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb6149200, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1ba8b20 sp=0x1ba8b0c pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x1d8a608, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ba8b34 sp=0x1ba8b20 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x1d8a5f0, {0x1ffc000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1ba8b7c sp=0x1ba8b34 pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x1d8a5f0, {0x1ffc000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1ba8ba8 sp=0x1ba8b7c pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x1b8d968, {0x1ffc000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1ba8bd4 sp=0x1ba8ba8 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*atLeastReader).Read(0x1c127d0, {0x1ffc000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1ba8c00 sp=0x1ba8bd4 pc=0x2674c0 Apr 03 13:12:46 volumio go-librespot[19491]: bytes.(*Buffer).ReadFrom(0x1c7884c, {0xa3a068, 0x1c127d0}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1ba8c3c sp=0x1ba8c00 pc=0x162058 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readFromUntil(0x1c786c8, {0xa38fa8, 0x1b8d968}, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1ba8c64 sp=0x1ba8c3c pc=0x26771c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecordOrCCS(0x1c786c8, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1ba8dc4 sp=0x1ba8c64 pc=0x264e40 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).Read(0x1c786c8, {0x1ff4000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1ba8df4 sp=0x1ba8dc4 pc=0x26ac04 Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).Read(0x1b925d0, {0x1ba08a4, 0x9, 0x9}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1ba8e18 sp=0x1ba8df4 pc=0x2b72a0 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadAtLeast({0xa391f8, 0x1b925d0}, {0x1ba08a4, 0x9, 0x9}, 0x9) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1ba8e44 sp=0x1ba8e18 pc=0xee954 Apr 03 13:12:46 volumio go-librespot[19491]: io.ReadFull(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.http2readFrameHeader({0x1ba08a4, 0x9, 0x9}, {0xa391f8, 0x1b925d0}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1ba8e6c sp=0x1ba8e44 pc=0x2f86ac Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Framer).ReadFrame(0x1ba0880) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1ba8ef4 sp=0x1ba8e6c pc=0x2f8e04 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2clientConnReadLoop).run(0x1ba8fdc) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1ba8fa4 sp=0x1ba8ef4 pc=0x31d33c Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2ClientConn).readLoop(0x26fd568) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1ba8fe4 sp=0x1ba8fa4 pc=0x31c604 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1ba8fec sp=0x1ba8fe4 pc=0x316960 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ba8fec sp=0x1ba8fec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*http2Transport).newClientConn in goroutine 7117671 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7103154 gp=0x1da45a8 m=nil [IO wait, 1 minutes]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x97745c, 0xb579e010, 0x2, 0x2, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1cdcb3c sp=0x1cdcb28 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.netpollblock(0xb579e000, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1cdcb54 sp=0x1cdcb3c pc=0x675a0 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.runtime_pollWait(0xb579e000, 0x72) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1cdcb68 sp=0x1cdcb54 pc=0xa8864 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).wait(0x3678568, 0x72, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1cdcb7c sp=0x1cdcb68 pc=0x136044 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:46 volumio go-librespot[19491]: internal/poll.(*FD).Read(0x3678550, {0x1d2a000, 0xa000, 0xa000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1cdcbc4 sp=0x1cdcb7c pc=0x1371c4 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*netFD).Read(0x3678550, {0x1d2a000, 0xa000, 0xa000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1cdcbf0 sp=0x1cdcbc4 pc=0x1a9e78 Apr 03 13:12:46 volumio go-librespot[19491]: net.(*conn).Read(0x1b60000, {0x1d2a000, 0xa000, 0xa000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1cdcc1c sp=0x1cdcbf0 pc=0x1b967c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*atLeastReader).Read(0x1a041b0, {0x1d2a000, 0xa000, 0xa000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1cdcc48 sp=0x1cdcc1c pc=0x2674c0 Apr 03 13:12:46 volumio go-librespot[19491]: bytes.(*Buffer).ReadFrom(0x1a4018c, {0xa3a068, 0x1a041b0}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1cdcc84 sp=0x1cdcc48 pc=0x162058 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readFromUntil(0x1a40008, {0xa38fa8, 0x1b60000}, 0x5) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1cdccac sp=0x1cdcc84 pc=0x26771c Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecordOrCCS(0x1a40008, 0x0) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1cdce0c sp=0x1cdccac pc=0x264e40 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:46 volumio go-librespot[19491]: crypto/tls.(*Conn).Read(0x1a40008, {0x1dd7000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1cdce3c sp=0x1cdce0c pc=0x26ac04 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*persistConn).Read(0x1a2cfd8, {0x1dd7000, 0x1000, 0x1000}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:2125 +0x16c fp=0x1cdce70 sp=0x1cdce3c pc=0x355e8c Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).fill(0x1be8060) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x1cdce94 sp=0x1cdce70 pc=0x2b6c1c Apr 03 13:12:46 volumio go-librespot[19491]: bufio.(*Reader).Peek(0x1be8060, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/bufio/bufio.go:152 +0x68 fp=0x1cdcea0 sp=0x1cdce94 pc=0x2b6da0 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*persistConn).readLoop(0x1a2cfd8) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:2278 +0x158 fp=0x1cdcfe4 sp=0x1cdcea0 pc=0x356804 Apr 03 13:12:46 volumio go-librespot[19491]: net/http.(*Transport).dialConn.gowrap2() Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:1947 +0x28 fp=0x1cdcfec sp=0x1cdcfe4 pc=0x35534c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1cdcfec sp=0x1cdcfec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by net/http.(*Transport).dialConn in goroutine 7103146 Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/net/http/transport.go:1947 +0x170c Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117938 gp=0x1da4fc8 m=nil [select]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1e72674 sp=0x1e72660 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.selectgo(0x1e72780, 0x1e7274c, 0x0, 0x0, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1e72724 sp=0x1e72674 pc=0x85000 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1b62c30) Apr 03 13:12:46 volumio go-librespot[19491]: /src/player/player.go:215 +0x1f4 fp=0x1e727e4 sp=0x1e72724 pc=0x582954 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Apr 03 13:12:46 volumio go-librespot[19491]: /src/player/player.go:197 +0x28 fp=0x1e727ec sp=0x1e727e4 pc=0x58253c Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1e727ec sp=0x1e727ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 84 Apr 03 13:12:46 volumio go-librespot[19491]: /src/player/player.go:197 +0x220 Apr 03 13:12:46 volumio go-librespot[19491]: goroutine 7117955 gp=0x1f24908 m=nil [select]: Apr 03 13:12:46 volumio go-librespot[19491]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1aa3684 sp=0x1aa3670 pc=0xa97c0 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.selectgo(0x1aa37d4, 0x1aa375c, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1aa3734 sp=0x1aa3684 pc=0x85000 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x1a2cd18) Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:138 +0x8c fp=0x1aa37e4 sp=0x1aa3734 pc=0x5a1d90 Apr 03 13:12:46 volumio go-librespot[19491]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:129 +0x28 fp=0x1aa37ec sp=0x1aa37e4 pc=0x5a3cd4 Apr 03 13:12:46 volumio go-librespot[19491]: runtime.goexit({}) Apr 03 13:12:46 volumio go-librespot[19491]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1aa37ec sp=0x1aa37ec pc=0xb0874 Apr 03 13:12:46 volumio go-librespot[19491]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 7117939 Apr 03 13:12:46 volumio go-librespot[19491]: /src/dealer/dealer.go:129 +0x15c Apr 03 13:12:46 volumio go-librespot[19490]: Aborted Apr 03 13:12:47 volumio systemd-backlight[4365]: 10-0045: Failed to write system 'brightness' attribute: Connection timed out Apr 03 13:12:47 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Main process exited, code=exited, status=1/FAILURE Apr 03 13:12:47 volumio systemd[1]: systemd-backlight@backlight:10-0045.service: Failed with result 'exit-code'. Apr 03 13:12:47 volumio systemd[1]: Failed to start systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045. Apr 03 13:12:47 volumio systemd[1]: Starting systemd-backlight@backlight:10-0045.service - Load/Save Screen Backlight Brightness of backlight:10-0045... Apr 03 13:12:49 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:49 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:49 volumio volumio[1412]: info: Initializing connection to go-librespot Websocket Apr 03 13:12:49 volumio volumio[1412]: info: Error connecting to go-librespot Websocket: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 03 13:12:49 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 3. Apr 03 13:12:49 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 13:12:49 volumio systemd[1]: go-librespot-daemon.service: Consumed 20min 11.061s CPU time. Apr 03 13:12:49 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 03 13:12:49 volumio go-librespot[4386]: go-librespot daemon starting... Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=info msg="running go-librespot 0.7.1" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=debug msg="app state loaded" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=info msg="zeroconf server listening on port 45557" Apr 03 13:12:49 volumio go-librespot[4387]: time="2026-04-03T13:12:49+08:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="obtained new client token: AAAp/ZQGXwAHOJ45RsesiY2Mcmg9o39AorQojqfHp3sCrPcgCZi+RKBsGJNY0SYjJO+Nv1fssd4+nhmAgW3eYstZQevZfzZ6/IL0lomy9L7zq9XIqq+UJ9U1xuQ/YLvb8RZCqNpmJUbdZ+MnPcD8Il4R7jglwNRi70loMIrq6lErhGGeMEBNy6a/UWyUbUcszMi337j24oi2OMym8j5MgIN2ZbbKreUGwaFNrTTkALaRc68fz6ISIw==" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="connected to ap-gae2.spotify.com:4070" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="completed keyexchange" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="completed challenge" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=info msg="authenticated AP" username="31************************su" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=info msg="authenticated Login5" username="31************************su" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="initializing zeroconf session" username="31************************su" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="dealer connection opened" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=trace msg="starting accesspoint recv loop" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=trace msg="starting dealer recv loop" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=trace msg="received accesspoint ping" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=debug msg="received connection id: NDU4ZjUwODgtOTA1...RThDNEM4NjY3RQ==" Apr 03 13:12:50 volumio go-librespot[4387]: time="2026-04-03T13:12:50+08:00" level=trace msg="received accesspoint pong ack" Apr 03 13:12:51 volumio go-librespot[4387]: time="2026-04-03T13:12:51+08:00" level=debug msg="put connect state because NEW_DEVICE" Apr 03 13:12:52 volumio volumio[1412]: info: Initializing connection to go-librespot Websocket Apr 03 13:12:52 volumio go-librespot[4387]: time="2026-04-03T13:12:52+08:00" level=debug msg="new websocket client" Apr 03 13:12:52 volumio volumio[1412]: info: Connection to go-librespot Websocket established Apr 03 13:12:52 volumio go-librespot[4387]: time="2026-04-03T13:12:52+08:00" level=debug msg="handling transfer player command from df977d0304723efd3dd7d95be7dfe0fc55726554" Apr 03 13:12:52 volumio go-librespot[4387]: time="2026-04-03T13:12:52+08:00" level=debug msg="resolved context of track" uri="spotify:station:playlist:6pmKqRDS6giOr74fD281bk" Apr 03 13:12:52 volumio go-librespot[4387]: panic: runtime error: invalid memory address or nil pointer dereference Apr 03 13:12:52 volumio go-librespot[4387]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x8 pc=0x49b308] Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 28 gp=0x1a3a368 m=4 mp=0x184d808 [running]: Apr 03 13:12:52 volumio go-librespot[4387]: panic({0x841d88, 0xfa0250}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x1c296d4 sp=0x1c29680 pc=0xa92ec Apr 03 13:12:52 volumio go-librespot[4387]: runtime.panicmem(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/panic.go:262 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.sigpanic() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x1c29704 sp=0x1c296d4 pc=0xabca4 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot.ContextTrackToProvidedTrack({0x919ccb, 0x5}, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /src/ids.go:25 +0x14 fp=0x1c29768 sp=0x1c29708 pc=0x49b308 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*AppPlayer).handlePlayerCommand(0x1a84690, {0xa3da8c, 0x1ba8370}, {0x51c22e27, {0x1b3f320, 0x28}, {{0x1a6b720, 0x8}, {0x0, 0x0}, ...}}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/player.go:202 +0x1858 fp=0x1c2989c sp=0x1c29768 pc=0x6c1e68 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*AppPlayer).handleDealerRequest(0x1a84690, {0xa3da1c, 0x1005090}, {0x1b01100, {0x1b3e570, 0x24}, {0x51c22e27, {0x1b3f320, 0x28}, {{0x1a6b720, ...}, ...}}}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/player.go:367 +0x194 fp=0x1c299e0 sp=0x1c2989c pc=0x6c2ae0 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*AppPlayer).Run(0x1a84690, {0xa3da1c, 0x1005090}, 0x187ae40, 0x187ae80) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/player.go:685 +0x638 fp=0x1c29fd4 sp=0x1c299e0 pc=0x6c5c20 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).withAppPlayer.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:274 +0x48 fp=0x1c29fec sp=0x1c29fd4 pc=0x6bd9f0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1c29fec sp=0x1c29fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:274 +0x46c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 1 gp=0x1802128 m=nil [select]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1b2cce0 sp=0x1b2cccc pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.selectgo(0x1b2cdf0, 0x1a05dbc, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1b2cd90 sp=0x1b2cce0 pc=0x85000 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x18a9a40, 0x1b2ce90) Apr 03 13:12:52 volumio go-librespot[4387]: /src/zeroconf/zeroconf.go:300 +0x228 fp=0x1b2ce38 sp=0x1b2cd90 pc=0x62f43c Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).withAppPlayer(0x1926880, {0xa3da1c, 0x1005090}, 0x1811900) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:340 +0x5dc fp=0x1b2ced0 sp=0x1b2ce38 pc=0x6bcc60 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).withCredentials(...) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:209 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).SpotifyToken(0x1926880, {0xa3da1c, 0x1005090}, {0x19229c0, 0x1c}, {0x187e3c0, 0x13e}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x1b2cf00 sp=0x1b2ced0 pc=0x6bc02c Apr 03 13:12:52 volumio go-librespot[4387]: main.main() Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:620 +0x660 fp=0x1b2cfa8 sp=0x1b2cf00 pc=0x6bf56c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.main() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x1b2cfec sp=0x1b2cfa8 pc=0x6f390 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1b2cfec sp=0x1b2cfec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 2 gp=0x18027e8 m=nil [force gc (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97746c, 0xff8fa8, 0x11, 0xa, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1848fd4 sp=0x1848fc0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goparkunlock(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.forcegchelper() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x1848fec sp=0x1848fd4 pc=0x6f7f4 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1848fec sp=0x1848fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.init.6 in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:361 +0x1c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 3 gp=0x1802b48 m=nil [GC sweep wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97746c, 0xff9850, 0xc, 0x9, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18497c4 sp=0x18497b0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goparkunlock(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.bgsweep(0x182e050) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x18497e4 sp=0x18497c4 pc=0x5768c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcenable.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x18497ec sp=0x18497e4 pc=0x46c3c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18497ec sp=0x18497ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcenable in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 4 gp=0x1802c68 m=nil [GC scavenge wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97746c, 0xffa170, 0xd, 0xa, 0x2) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1849fb4 sp=0x1849fa0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goparkunlock(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.(*scavengerState).park(0xffa170) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x1849fc8 sp=0x1849fb4 pc=0x54a28 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.bgscavenge(0x182e050) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x1849fe4 sp=0x1849fc8 pc=0x5516c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcenable.gowrap2() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x1849fec sp=0x1849fe4 pc=0x46be8 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1849fec sp=0x1849fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcenable in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 5 gp=0x1802fc8 m=nil [GOMAXPROCS updater (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97746c, 0xff95e8, 0x12, 0xa, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x184a7a4 sp=0x184a790 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goparkunlock(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.updateMaxProcsGoroutine() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x184a7ec sp=0x184a7a4 pc=0x7f174 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x184a7ec sp=0x184a7ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 6 gp=0x1803328 m=nil [finalizer wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x977314, 0x1005180, 0x10, 0xa, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x184af88 sp=0x184af74 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.runFinalizers() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x184afec sp=0x184af88 pc=0x45888 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x184afec sp=0x184afec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.createfing in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 7 gp=0x19de908 m=nil [cleanup wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97746c, 0xffa348, 0x2e, 0xa, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18487a4 sp=0x1848790 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goparkunlock(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:466 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.(*cleanupQueue).dequeue(0xffa2e8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x18487c4 sp=0x18487a4 pc=0x41cb0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.runCleanups() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x18487ec sp=0x18487c4 pc=0x4284c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18487ec sp=0x18487ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 10 gp=0x19dfb08 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158e10, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1856cf0 sp=0x1856cdc pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158e00, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1856d08 sp=0x1856cf0 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158e00, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1856d1c sp=0x1856d08 pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x190b468, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1856d30 sp=0x1856d1c pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Accept(0x190b450) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1856d78 sp=0x1856d30 pc=0x13a800 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).accept(0x190b450) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1856de0 sp=0x1856d78 pc=0x1abc28 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*TCPListener).accept(0x1800630) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1856e34 sp=0x1856de0 pc=0x1c3554 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*TCPListener).Accept(0x1800630) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1856e50 sp=0x1856e34 pc=0x1c259c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*onceCloseListener).Accept(0x18a4080) Apr 03 13:12:52 volumio go-librespot[4387]: :1 +0x34 fp=0x1856e68 sp=0x1856e50 pc=0x367f9c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*Server).Serve(0x18b4008, {0xa3d218, 0x1800630}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1856f00 sp=0x1856e68 pc=0x341154 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.Serve(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2971 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*ConcreteApiServer).serve(0x182a900) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x1856fe4 sp=0x1856f00 pc=0x6b17bc Apr 03 13:12:52 volumio go-librespot[4387]: main.NewApiServer.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x1856fec sp=0x1856fe4 pc=0x6b04f4 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1856fec sp=0x1856fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by main.NewApiServer in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/api_server.go:332 +0x310 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 41 gp=0x19dfc28 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158810, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x185bcbc sp=0x185bca8 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158800, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x185bcd4 sp=0x185bcbc pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158800, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x185bce8 sp=0x185bcd4 pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x19f52d8, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x185bcfc sp=0x185bce8 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).ReadMsg(0x19f52c0, {0x1af3290, 0x10, 0x10}, {0x1969918, 0x1000, 0x1000}, 0x40000000) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:295 +0x2c0 fp=0x185bd6c sp=0x185bcfc pc=0x1381bc Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).readMsg(0x19f52c0, {0x1af3290, 0x10, 0x10}, {0x1969918, 0x1000, 0x1000}, 0x40000000) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:91 +0x58 fp=0x185bdc8 sp=0x185bd6c pc=0x1aa2c8 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*UnixConn).readMsg(0x18333e0, {0x1af3290, 0x10, 0x10}, {0x1969918, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/unixsock_posix.go:115 +0x58 fp=0x185be28 sp=0x185bdc8 pc=0x1c9d80 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*UnixConn).ReadMsgUnix(0x18333e0, {0x1af3290, 0x10, 0x10}, {0x1969918, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/unixsock.go:143 +0x58 fp=0x185be78 sp=0x185be28 pc=0x1c820c Apr 03 13:12:52 volumio go-librespot[4387]: github.com/godbus/dbus/v5.(*oobReader).Read(0x1969908, {0x1af3290, 0x10, 0x10}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:41 +0x50 fp=0x185bec8 sp=0x185be78 pc=0x4c2af0 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa39d58, 0x1969908}, {0x1af3290, 0x10, 0x10}, 0x10) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x185bef4 sp=0x185bec8 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/godbus/dbus/v5.(*unixTransport).ReadMessage(0x18106c0) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:124 +0x224 fp=0x185bfa0 sp=0x185bef4 pc=0x4c32c4 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/godbus/dbus/v5.(*Conn).inWorker(0x1926600) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:390 +0x44 fp=0x185bfe4 sp=0x185bfa0 pc=0x4aaef4 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/godbus/dbus/v5.(*Conn).Auth.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x28 fp=0x185bfec sp=0x185bfe4 pc=0x4a8318 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x185bfec sp=0x185bfec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/godbus/dbus/v5.(*Conn).Auth in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x77c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 39 gp=0x1a3a008 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158c10, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1b30af4 sp=0x1b30ae0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158c00, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1b30b0c sp=0x1b30af4 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158c00, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1b30b20 sp=0x1b30b0c pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x190b6e8, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1b30b34 sp=0x1b30b20 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x190b6d0, {0x18e0000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1b30b7c sp=0x1b30b34 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x190b6d0, {0x18e0000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1b30ba8 sp=0x1b30b7c pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x18981f8, {0x18e0000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1b30bd4 sp=0x1b30ba8 pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*atLeastReader).Read(0x1a44100, {0x18e0000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1b30c00 sp=0x1b30bd4 pc=0x2674c0 Apr 03 13:12:52 volumio go-librespot[4387]: bytes.(*Buffer).ReadFrom(0x18ba18c, {0xa3a068, 0x1a44100}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1b30c3c sp=0x1b30c00 pc=0x162058 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readFromUntil(0x18ba008, {0xa38fa8, 0x18981f8}, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1b30c64 sp=0x1b30c3c pc=0x26771c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecordOrCCS(0x18ba008, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1b30dc4 sp=0x1b30c64 pc=0x264e40 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).Read(0x18ba008, {0x1965000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1b30df4 sp=0x1b30dc4 pc=0x26ac04 Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).Read(0x1a82000, {0x18900a4, 0x9, 0x9}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1b30e18 sp=0x1b30df4 pc=0x2b72a0 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa391f8, 0x1a82000}, {0x18900a4, 0x9, 0x9}, 0x9) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1b30e44 sp=0x1b30e18 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.http2readFrameHeader({0x18900a4, 0x9, 0x9}, {0xa391f8, 0x1a82000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1b30e6c sp=0x1b30e44 pc=0x2f86ac Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Framer).ReadFrame(0x1890080) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1b30ef4 sp=0x1b30e6c pc=0x2f8e04 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2clientConnReadLoop).run(0x1b30fdc) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1b30fa4 sp=0x1b30ef4 pc=0x31d33c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2ClientConn).readLoop(0x18826c8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1b30fe4 sp=0x1b30fa4 pc=0x31c604 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1b30fec sp=0x1b30fe4 pc=0x316960 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1b30fec sp=0x1b30fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by net/http.(*http2Transport).newClientConn in goroutine 38 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 34 gp=0x1ca4008 m=nil [GC worker (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x977320, 0x1c4c200, 0x1c, 0xa, 0x0) Apr 03 13:12:52 volumio volumio[1412]: info: Connection to go-librespot Websocket closed Apr 03 13:12:52 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1845f88 sp=0x1845f74 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkWorker(0x1c217c0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1845fe4 sp=0x1845f88 pc=0x49f34 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1845fec sp=0x1845fe4 pc=0x49e14 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1845fec sp=0x1845fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcBgMarkStartWorkers in goroutine 18 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 35 gp=0x1ca4128 m=nil [GC worker (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x977320, 0x1c4c400, 0x1c, 0xa, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1caaf88 sp=0x1caaf74 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkWorker(0x1c217c0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1caafe4 sp=0x1caaf88 pc=0x49f34 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1caafec sp=0x1caafe4 pc=0x49e14 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1caafec sp=0x1caafec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcBgMarkStartWorkers in goroutine 18 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 36 gp=0x1ca4248 m=nil [GC worker (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x977320, 0x1c4c600, 0x1c, 0xa, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1cab788 sp=0x1cab774 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkWorker(0x1c217c0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1cab7e4 sp=0x1cab788 pc=0x49f34 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1cab7ec sp=0x1cab7e4 pc=0x49e14 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1cab7ec sp=0x1cab7ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcBgMarkStartWorkers in goroutine 18 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 37 gp=0x1ca4368 m=nil [GC worker (idle)]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x977320, 0x1c4c800, 0x1c, 0xa, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1beff88 sp=0x1beff74 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkWorker(0x1c217c0) Apr 03 13:12:52 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x1beffe4 sp=0x1beff88 pc=0x49f34 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x1beffec sp=0x1beffe4 pc=0x49e14 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1beffec sp=0x1beffec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by runtime.gcBgMarkStartWorkers in goroutine 18 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 16 gp=0x1ca4488 m=nil [chan receive]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9772f4, 0x1c205f8, 0xe, 0x7, 0x2) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ca9778 sp=0x1ca9764 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv(0x1c205c0, 0x0, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1ca97c0 sp=0x1ca9778 pc=0x3414c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv1(0x1c205c0, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x1ca97d4 sp=0x1ca97c0 pc=0x33bcc Apr 03 13:12:52 volumio go-librespot[4387]: github.com/godbus/dbus/v5.newConn.func1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:303 +0x40 fp=0x1ca97ec sp=0x1ca97d4 pc=0x4aa8ec Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ca97ec sp=0x1ca97ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/godbus/dbus/v5.newConn in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:302 +0x52c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 57 gp=0x1a3a128 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158210, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1857af4 sp=0x1857ae0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158200, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1857b0c sp=0x1857af4 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158200, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1857b20 sp=0x1857b0c pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x1b875a8, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1857b34 sp=0x1857b20 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x1b87590, {0x1ad4000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1857b7c sp=0x1857b34 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x1b87590, {0x1ad4000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1857ba8 sp=0x1857b7c pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x1c04ad8, {0x1ad4000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1857bd4 sp=0x1857ba8 pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*atLeastReader).Read(0x1a45ab0, {0x1ad4000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1857c00 sp=0x1857bd4 pc=0x2674c0 Apr 03 13:12:52 volumio go-librespot[4387]: bytes.(*Buffer).ReadFrom(0x19fd14c, {0xa3a068, 0x1a45ab0}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1857c3c sp=0x1857c00 pc=0x162058 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readFromUntil(0x19fcfc8, {0xa38fa8, 0x1c04ad8}, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1857c64 sp=0x1857c3c pc=0x26771c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecordOrCCS(0x19fcfc8, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1857dc4 sp=0x1857c64 pc=0x264e40 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).Read(0x19fcfc8, {0x1ae6000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1857df4 sp=0x1857dc4 pc=0x26ac04 Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).Read(0x1ad24b0, {0x1890924, 0x9, 0x9}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1857e18 sp=0x1857df4 pc=0x2b72a0 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa391f8, 0x1ad24b0}, {0x1890924, 0x9, 0x9}, 0x9) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1857e44 sp=0x1857e18 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.http2readFrameHeader({0x1890924, 0x9, 0x9}, {0xa391f8, 0x1ad24b0}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1857e6c sp=0x1857e44 pc=0x2f86ac Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Framer).ReadFrame(0x1890900) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1857ef4 sp=0x1857e6c pc=0x2f8e04 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2clientConnReadLoop).run(0x1857fdc) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1857fa4 sp=0x1857ef4 pc=0x31d33c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2ClientConn).readLoop(0x1883328) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1857fe4 sp=0x1857fa4 pc=0x31c604 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1857fec sp=0x1857fe4 pc=0x316960 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1857fec sp=0x1857fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by net/http.(*http2Transport).newClientConn in goroutine 56 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 69 gp=0x1882ea8 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158610, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1859af4 sp=0x1859ae0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158600, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1859b0c sp=0x1859af4 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158600, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1859b20 sp=0x1859b0c pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x1a85dc8, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1859b34 sp=0x1859b20 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x1a85db0, {0x1a32000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1859b7c sp=0x1859b34 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x1a85db0, {0x1a32000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1859ba8 sp=0x1859b7c pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x1833480, {0x1a32000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1859bd4 sp=0x1859ba8 pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*atLeastReader).Read(0x1810ba0, {0x1a32000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1859c00 sp=0x1859bd4 pc=0x2674c0 Apr 03 13:12:52 volumio go-librespot[4387]: bytes.(*Buffer).ReadFrom(0x18baf0c, {0xa3a068, 0x1810ba0}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1859c3c sp=0x1859c00 pc=0x162058 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readFromUntil(0x18bad88, {0xa38fa8, 0x1833480}, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1859c64 sp=0x1859c3c pc=0x26771c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecordOrCCS(0x18bad88, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1859dc4 sp=0x1859c64 pc=0x264e40 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).Read(0x18bad88, {0x1a54000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1859df4 sp=0x1859dc4 pc=0x26ac04 Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).Read(0x1a4c060, {0x19269a4, 0x9, 0x9}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1859e18 sp=0x1859df4 pc=0x2b72a0 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa391f8, 0x1a4c060}, {0x19269a4, 0x9, 0x9}, 0x9) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1859e44 sp=0x1859e18 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.http2readFrameHeader({0x19269a4, 0x9, 0x9}, {0xa391f8, 0x1a4c060}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1859e6c sp=0x1859e44 pc=0x2f86ac Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Framer).ReadFrame(0x1926980) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1859ef4 sp=0x1859e6c pc=0x2f8e04 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2clientConnReadLoop).run(0x1859fdc) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1859fa4 sp=0x1859ef4 pc=0x31d33c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2ClientConn).readLoop(0x1ca46c8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1859fe4 sp=0x1859fa4 pc=0x31c604 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1859fec sp=0x1859fe4 pc=0x316960 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1859fec sp=0x1859fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by net/http.(*http2Transport).newClientConn in goroutine 68 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 27 gp=0x1a3a248 m=nil [select]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1844674 sp=0x1844660 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.selectgo(0x1844780, 0x184474c, 0x0, 0x0, 0x3, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1844724 sp=0x1844674 pc=0x85000 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x1bae140) Apr 03 13:12:52 volumio go-librespot[4387]: /src/player/player.go:215 +0x1f4 fp=0x18447e4 sp=0x1844724 pc=0x582954 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/player/player.go:197 +0x28 fp=0x18447ec sp=0x18447e4 pc=0x58253c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18447ec sp=0x18447ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/player/player.go:197 +0x220 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 29 gp=0x1a3a488 m=nil [chan receive]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9772f4, 0x187a238, 0xe, 0x7, 0x2) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1bb773c sp=0x1bb7728 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv(0x187a200, 0x1bb77d0, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1bb7784 sp=0x1bb773c pc=0x3414c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv2(0x187a200, 0x1bb77d0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x1bb7798 sp=0x1bb7784 pc=0x33bf0 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).withAppPlayer.func1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:284 +0x68 fp=0x1bb77ec sp=0x1bb7798 pc=0x6bd918 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1bb77ec sp=0x1bb77ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:281 +0x4f8 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 30 gp=0x1a3a5a8 m=nil [chan receive]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9772f4, 0x187a1f8, 0xe, 0x7, 0x2) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1bb7f40 sp=0x1bb7f2c pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv(0x187a1c0, 0x1bb7fe0, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1bb7f88 sp=0x1bb7f40 pc=0x3414c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv2(0x187a1c0, 0x1bb7fe0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x1bb7f9c sp=0x1bb7f88 pc=0x33bf0 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*App).withAppPlayer.func2() Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:300 +0x6c fp=0x1bb7fec sp=0x1bb7f9c pc=0x6bd47c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1bb7fec sp=0x1bb7fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/main.go:297 +0x598 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 31 gp=0x1a3a6c8 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158a10, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ca65ac sp=0x1ca6598 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158a00, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1ca65c4 sp=0x1ca65ac pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158a00, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1ca65d8 sp=0x1ca65c4 pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x19f5288, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ca65ec sp=0x1ca65d8 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Accept(0x19f5270) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x1ca6634 sp=0x1ca65ec pc=0x13a800 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).accept(0x19f5270) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x1ca669c sp=0x1ca6634 pc=0x1abc28 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*TCPListener).accept(0x1a08e10) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x1ca66f0 sp=0x1ca669c pc=0x1c3554 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*TCPListener).Accept(0x1a08e10) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x1ca670c sp=0x1ca66f0 pc=0x1c259c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*onceCloseListener).Accept(0x1b947c0) Apr 03 13:12:52 volumio go-librespot[4387]: :1 +0x34 fp=0x1ca6724 sp=0x1ca670c pc=0x367f9c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*Server).Serve(0x1c10dc8, {0xa3d218, 0x1a08e10}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x1ca67bc sp=0x1ca6724 pc=0x341154 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.Serve(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2971 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Apr 03 13:12:52 volumio go-librespot[4387]: /src/zeroconf/zeroconf.go:297 +0x8c fp=0x1ca67ec sp=0x1ca67bc pc=0x62f538 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ca67ec sp=0x1ca67ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Apr 03 13:12:52 volumio go-librespot[4387]: /src/zeroconf/zeroconf.go:297 +0x160 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 82 gp=0x1a3aa28 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb6158410, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1b2fd04 sp=0x1b2fcf0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb6158400, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1b2fd1c sp=0x1b2fd04 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb6158400, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1b2fd30 sp=0x1b2fd1c pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x1ab28d8, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1b2fd44 sp=0x1b2fd30 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x1ab28c0, {0x1a6a6bc, 0x3, 0x3}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1b2fd8c sp=0x1b2fd44 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x1ab28c0, {0x1a6a6bc, 0x3, 0x3}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1b2fdb8 sp=0x1b2fd8c pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x1b38288, {0x1a6a6bc, 0x3, 0x3}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1b2fde4 sp=0x1b2fdb8 pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa38fa8, 0x1b38288}, {0x1a6a6bc, 0x3, 0x3}, 0x3) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1b2fe10 sp=0x1b2fde4 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x1a29700, {0xa3da1c, 0x1005090}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/shannon.go:124 +0x370 fp=0x1b2fed4 sp=0x1b2fe10 pc=0x4fac0c Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x1951608) Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:289 +0x68 fp=0x1b2ffe4 sp=0x1b2fed4 pc=0x4f74ac Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:273 +0x28 fp=0x1b2ffec sp=0x1b2ffe4 pc=0x4f7418 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1b2ffec sp=0x1b2ffec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 28 Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:273 +0x98 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 83 gp=0x1a3ab48 m=nil [select]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x18456a4 sp=0x1845690 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.selectgo(0x18457d4, 0x1845778, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1845754 sp=0x18456a4 pc=0x85000 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x1951608) Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:368 +0x8c fp=0x18457e4 sp=0x1845754 pc=0x4f7cf8 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:277 +0x28 fp=0x18457ec sp=0x18457e4 pc=0x4f73c4 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x18457ec sp=0x18457ec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 28 Apr 03 13:12:52 volumio go-librespot[4387]: /src/ap/ap.go:277 +0x15c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 84 gp=0x1a3ac68 m=nil [chan receive]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9772f4, 0x1b01138, 0xe, 0x7, 0x2) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1837d44 sp=0x1837d30 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv(0x1b01100, 0x1837dcb, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x1837d8c sp=0x1837d44 pc=0x3414c Apr 03 13:12:52 volumio go-librespot[4387]: runtime.chanrecv1(0x1b01100, 0x1837dcb) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x1837da0 sp=0x1837d8c pc=0x33bcc Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/dealer.(*Dealer).handleRequest(0x1c10d18, 0x1a84730) Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/recv.go:237 +0x1f8 fp=0x1837f1c sp=0x1837da0 pc=0x5a3fa0 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x1c10d18) Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:213 +0x4d0 fp=0x1837fe4 sp=0x1837f1c pc=0x5a26a4 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:125 +0x28 fp=0x1837fec sp=0x1837fe4 pc=0x5a3d28 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1837fec sp=0x1837fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 28 Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:125 +0x98 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 85 gp=0x1a3ad88 m=nil [select]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1846e84 sp=0x1846e70 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.selectgo(0x1846fd4, 0x1846f5c, 0x0, 0x0, 0x2, 0x1) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x1846f34 sp=0x1846e84 pc=0x85000 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x1c10d18) Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:138 +0x8c fp=0x1846fe4 sp=0x1846f34 pc=0x5a1d90 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:129 +0x28 fp=0x1846fec sp=0x1846fe4 pc=0x5a3cd4 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1846fec sp=0x1846fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 28 Apr 03 13:12:52 volumio go-librespot[4387]: /src/dealer/dealer.go:129 +0x15c Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 74 gp=0x1a3b688 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb4596010, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1b33af4 sp=0x1b33ae0 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb4596000, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1b33b0c sp=0x1b33af4 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb4596000, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1b33b20 sp=0x1b33b0c pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x190bc88, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1b33b34 sp=0x1b33b20 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x190bc70, {0x1a55000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1b33b7c sp=0x1b33b34 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x190bc70, {0x1a55000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1b33ba8 sp=0x1b33b7c pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x1c041c8, {0x1a55000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1b33bd4 sp=0x1b33ba8 pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*atLeastReader).Read(0x1b342f0, {0x1a55000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x1b33c00 sp=0x1b33bd4 pc=0x2674c0 Apr 03 13:12:52 volumio go-librespot[4387]: bytes.(*Buffer).ReadFrom(0x19fc18c, {0xa3a068, 0x1b342f0}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x1b33c3c sp=0x1b33c00 pc=0x162058 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readFromUntil(0x19fc008, {0xa38fa8, 0x1c041c8}, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x1b33c64 sp=0x1b33c3c pc=0x26771c Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecordOrCCS(0x19fc008, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x1b33dc4 sp=0x1b33c64 pc=0x264e40 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).readRecord(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 13:12:52 volumio go-librespot[4387]: crypto/tls.(*Conn).Read(0x19fc008, {0x1b55000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x1b33df4 sp=0x1b33dc4 pc=0x26ac04 Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).Read(0x1ad3650, {0x1890124, 0x9, 0x9}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x1b33e18 sp=0x1b33df4 pc=0x2b72a0 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadAtLeast({0xa391f8, 0x1ad3650}, {0x1890124, 0x9, 0x9}, 0x9) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x1b33e44 sp=0x1b33e18 pc=0xee954 Apr 03 13:12:52 volumio go-librespot[4387]: io.ReadFull(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/io.go:354 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.http2readFrameHeader({0x1890124, 0x9, 0x9}, {0xa391f8, 0x1ad3650}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x1b33e6c sp=0x1b33e44 pc=0x2f86ac Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Framer).ReadFrame(0x1890100) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x1b33ef4 sp=0x1b33e6c pc=0x2f8e04 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2clientConnReadLoop).run(0x1b33fdc) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x1b33fa4 sp=0x1b33ef4 pc=0x31d33c Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2ClientConn).readLoop(0x1882c68) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x1b33fe4 sp=0x1b33fa4 pc=0x31c604 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x1b33fec sp=0x1b33fe4 pc=0x316960 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1b33fec sp=0x1b33fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by net/http.(*http2Transport).newClientConn in goroutine 73 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 13:12:52 volumio go-librespot[4387]: goroutine 91 gp=0x1a3bb08 m=nil [IO wait]: Apr 03 13:12:52 volumio go-librespot[4387]: runtime.gopark(0x97745c, 0xb4595e10, 0x2, 0x2, 0x5) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x1ba7908 sp=0x1ba78f4 pc=0xa97c0 Apr 03 13:12:52 volumio go-librespot[4387]: runtime.netpollblock(0xb4595e00, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x1ba7920 sp=0x1ba7908 pc=0x675a0 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.runtime_pollWait(0xb4595e00, 0x72) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x1ba7934 sp=0x1ba7920 pc=0xa8864 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).wait(0x1ac3328, 0x72, 0x0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x1ba7948 sp=0x1ba7934 pc=0x136044 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*pollDesc).waitRead(...) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 13:12:52 volumio go-librespot[4387]: internal/poll.(*FD).Read(0x1ac3310, {0x1aad000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x1ba7990 sp=0x1ba7948 pc=0x1371c4 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*netFD).Read(0x1ac3310, {0x1aad000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x1ba79bc sp=0x1ba7990 pc=0x1a9e78 Apr 03 13:12:52 volumio go-librespot[4387]: net.(*conn).Read(0x1b39ef0, {0x1aad000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x1ba79e8 sp=0x1ba79bc pc=0x1b967c Apr 03 13:12:52 volumio go-librespot[4387]: io.(*multiReader).Read(0x1b23110, {0x1aad000, 0x1000, 0x1000}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x1ba7a14 sp=0x1ba79e8 pc=0xefb88 Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).fill(0x1a09bc0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x1ba7a38 sp=0x1ba7a14 pc=0x2b6c1c Apr 03 13:12:52 volumio go-librespot[4387]: bufio.(*Reader).ReadByte(0x1a09bc0) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x1ba7a44 sp=0x1ba7a38 pc=0x2b7498 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.readFrameHeader(0x1a09bc0, {0x195cdb8, 0x8, 0x8}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x1ba7a84 sp=0x1ba7a44 pc=0x372a08 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.(*Conn).readFrameHeader(0x195cd88, {0xa3da00, 0x1005090}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x1ba7b08 sp=0x1ba7a84 pc=0x375bd4 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.(*Conn).readLoop(0x195cd88, {0xa3da00, 0x1005090}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x1ba7bcc sp=0x1ba7b08 pc=0x375390 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.(*Conn).reader(0x195cd88, {0xa3da00, 0x1005090}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x1ba7c50 sp=0x1ba7bcc pc=0x376798 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.(*Conn).Reader(...) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Apr 03 13:12:52 volumio go-librespot[4387]: github.com/coder/websocket.(*Conn).Read(0x195cd88, {0xa3da00, 0x1005090}) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x1ba7c78 sp=0x1ba7c50 pc=0x374944 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*ConcreteApiServer).serve.func17({0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /src/cmd/daemon/api_server.go:636 +0x3b4 fp=0x1ba7cfc sp=0x1ba7c78 pc=0x6b2040 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.HandlerFunc.ServeHTTP(0x1898188, {0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1ba7d0c sp=0x1ba7cfc pc=0x33d7d8 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*ServeMux).ServeHTTP(0x1890000, {0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x1ba7d4c sp=0x1ba7d0c pc=0x33f6c8 Apr 03 13:12:52 volumio go-librespot[4387]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x1ba7d74 sp=0x1ba7d4c pc=0x6b19b8 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.HandlerFunc.ServeHTTP(0x1894140, {0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x1ba7d84 sp=0x1ba7d74 pc=0x33d7d8 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.serverHandler.ServeHTTP({0x18b4008}, {0xa3d2d8, 0x1af0d18}, 0x1af0bb8) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x1ba7da0 sp=0x1ba7d84 pc=0x35cb44 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*conn).serve(0x18fefc0, {0xa3da38, 0x18a21e0}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x1ba7fdc sp=0x1ba7da0 pc=0x33b894 Apr 03 13:12:52 volumio go-librespot[4387]: net/http.(*Server).Serve.gowrap3() Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x1ba7fec sp=0x1ba7fdc pc=0x3415cc Apr 03 13:12:52 volumio go-librespot[4387]: runtime.goexit({}) Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x1ba7fec sp=0x1ba7fec pc=0xb0874 Apr 03 13:12:52 volumio go-librespot[4387]: created by net/http.(*Server).Serve in goroutine 10 Apr 03 13:12:52 volumio go-librespot[4387]: /usr/local/go/src/net/http/server.go:3493 +0x42c Apr 03 13:12:52 volumio go-librespot[4386]: Aborted Apr 03 13:12:54 volumio volumio[1412]: info: Discovery: Remote connection error: 192.168.50.112 Apr 03 13:12:55 volumio volumio[1412]: info: Getting Spotify volume Apr 03 13:12:55 volumio volumio[1412]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 13:12:55 volumio volumio[1412]: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 03 13:12:55 volumio volumio[1412]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 03 13:12:55 volumio volumio[1412]: errno: -111, Apr 03 13:12:55 volumio volumio[1412]: code: 'ECONNREFUSED', Apr 03 13:12:55 volumio volumio[1412]: syscall: 'connect', Apr 03 13:12:55 volumio volumio[1412]: address: '127.0.0.1', Apr 03 13:12:55 volumio volumio[1412]: port: 9879, Apr 03 13:12:55 volumio volumio[1412]: response: undefined Apr 03 13:12:55 volumio volumio[1412]: } Apr 03 13:12:55 volumio volumio[1412]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 13:12:55 volumio systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 4. Apr 03 13:12:55 volumio systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 13:12:55 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 03 13:12:55 volumio go-librespot[4424]: go-librespot daemon starting... Apr 03 13:12:55 volumio go-librespot[4425]: time="2026-04-03T13:12:55+08:00" level=info msg="running go-librespot 0.7.1" Apr 03 13:12:55 volumio go-librespot[4425]: time="2026-04-03T13:12:55+08:00" level=debug msg="app state loaded" Apr 03 13:12:55 volumio go-librespot[4425]: time="2026-04-03T13:12:55+08:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 03 13:12:56 volumio sudo[4435]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 13:11' Apr 03 13:12:56 volumio sudo[4435]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"