Apr 03 14:11:00 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:00 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:00 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:01 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:03 soundsystem go-librespot[1932]: time="2026-04-03T14:11:03-04:00" level=debug msg="fetched chunk 22/22, size: 450237" uri="spotify:track:5Nt5kpCSEYKci7hyY6yu5I" Apr 03 14:11:04 soundsystem go-librespot[1932]: time="2026-04-03T14:11:04-04:00" level=trace msg="sent dealer ping" Apr 03 14:11:04 soundsystem go-librespot[1932]: time="2026-04-03T14:11:04-04:00" level=trace msg="received dealer pong" Apr 03 14:11:10 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:11 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:19 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 14:11:19 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 03 14:11:20 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:20 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:20 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:21 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:22 soundsystem volumio[1401]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="prefetching next track" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="selected format OGG_VORBIS_320 (a0fee35d0b3078053aef1d322c8d74543060079f)" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="requested aes key for file a0fee35d0b3078053aef1d322c8d74543060079f, gid: 11AURg9Kbju7LOcwQnR17f" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=trace msg="found 2 cdn urls" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="fetched first chunk of 16, total size is 8051432 bytes" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=info msg="prefetched track \"Cómo Me Quieres\" (duration: 225153ms)" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="fetched chunk 3/15, size: 524288" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="fetched chunk 1/15, size: 524288" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:23 soundsystem go-librespot[1932]: time="2026-04-03T14:11:23-04:00" level=debug msg="fetched chunk 2/15, size: 524288" uri="spotify:track:2pCnrWHxYVDWN3S4PgNMa0" Apr 03 14:11:30 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:31 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:34 soundsystem go-librespot[1932]: time="2026-04-03T14:11:34-04:00" level=trace msg="received accesspoint ping" Apr 03 14:11:34 soundsystem go-librespot[1932]: time="2026-04-03T14:11:34-04:00" level=trace msg="received accesspoint pong ack" Apr 03 14:11:34 soundsystem go-librespot[1932]: time="2026-04-03T14:11:34-04:00" level=trace msg="sent dealer ping" Apr 03 14:11:34 soundsystem go-librespot[1932]: time="2026-04-03T14:11:34-04:00" level=trace msg="received dealer pong" Apr 03 14:11:35 soundsystem systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 03 14:11:35 soundsystem systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 03 14:11:35 soundsystem systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 03 14:11:35 soundsystem nmbd[1302]: [2026/04/03 14:11:35.852104, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 03 14:11:35 soundsystem nmbd[1302]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.106 for name WORKGROUP<1d>. Apr 03 14:11:35 soundsystem nmbd[1302]: This response was from IP 192.168.1.105, reporting an IP address of 192.168.1.105. Apr 03 14:11:40 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:40 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:40 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:41 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:47 soundsystem volumio[1401]: info: Received OAUTH Data Apr 03 14:11:47 soundsystem volumio[1401]: info: Executing Spotify Oauth Login Apr 03 14:11:47 soundsystem volumio[1401]: info: Saving Spotify Refresh Token Apr 03 14:11:47 soundsystem sudo[13808]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 03 14:11:47 soundsystem sudo[13808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 14:11:47 soundsystem sudo[13810]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 03 14:11:47 soundsystem sudo[13808]: pam_unix(sudo:session): session closed for user root Apr 03 14:11:47 soundsystem sudo[13810]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 14:11:47 soundsystem sudo[13810]: pam_unix(sudo:session): session closed for user root Apr 03 14:11:47 soundsystem volumio[1401]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.180 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:140.0) Gecko/20100101 Firefox/140.0 Engine version: 3 Transport: polling Total Clients: 11 Apr 03 14:11:47 soundsystem volumio[1401]: info: New Spotify access tokenBQDfttPxy6... Apr 03 14:11:47 soundsystem volumio[1401]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetVisibleSources Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 03 14:11:47 soundsystem volumio[1401]: info: Received Get System Info Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 14:11:47 soundsystem volumio[1401]: info: Discovery: Getting this device information Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:47 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 14:11:47 soundsystem volumio[1401]: SPOTIFY: User informations: {"country":"US","display_name":"dubcyantist","email":"hudsonva@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/dubcyantist"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/dubcyantist","id":"dubcyantist","images":[],"product":"premium","type":"user","uri":"spotify:user:dubcyantist"} Apr 03 14:11:47 soundsystem volumio[1401]: info: Creating Spotify config file Apr 03 14:11:47 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 14:11:47 soundsystem volumio[1401]: info: Spotify config file written Apr 03 14:11:47 soundsystem sudo[13814]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 14:11:47 soundsystem sudo[13814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 14:11:47 soundsystem systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Apr 03 14:11:47 soundsystem systemd[1]: go-librespot-daemon.service: Deactivated successfully. Apr 03 14:11:47 soundsystem systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 14:11:47 soundsystem systemd[1]: go-librespot-daemon.service: Consumed 1min 55.563s CPU time. Apr 03 14:11:47 soundsystem volumio[1401]: info: Connection to go-librespot Websocket closed Apr 03 14:11:47 soundsystem systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 03 14:11:47 soundsystem go-librespot[13816]: go-librespot daemon starting... Apr 03 14:11:47 soundsystem sudo[13814]: pam_unix(sudo:session): session closed for user root Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=info msg="running go-librespot 0.7.1" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=debug msg="app state loaded" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=debug msg="stored credentials not found" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 03 14:11:47 soundsystem volumio[1401]: info: New Spotify access tokenBQDqFhXSF9... Apr 03 14:11:47 soundsystem volumio[1401]: info: Spotify credentials grant success - running version from March 24, 2019 Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=info msg="zeroconf server listening on port 46063" Apr 03 14:11:47 soundsystem go-librespot[13817]: time="2026-04-03T14:11:47-04:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Apr 03 14:11:48 soundsystem volumio[1401]: SPOTIFY: User informations: {"country":"US","display_name":"dubcyantist","email":"hudsonva@gmail.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/dubcyantist"},"followers":{"href":null,"total":6},"href":"https://api.spotify.com/v1/users/dubcyantist","id":"dubcyantist","images":[],"product":"premium","type":"user","uri":"spotify:user:dubcyantist"} Apr 03 14:11:48 soundsystem volumio[1401]: info: Spotify Successfully logged in Apr 03 14:11:48 soundsystem volumio[1401]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 03 14:11:48 soundsystem volumio[1401]: info: [1775239908014] CoreMusicLibrary::Adding element Spotify Apr 03 14:11:48 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 03 14:11:48 soundsystem volumio[1401]: Cannot find translation for source SoundCloud Apr 03 14:11:48 soundsystem volumio[1401]: Cannot find translation for source Spotify Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="obtained new client token: AABJKCFkgiVXU0KHUdEIOUPWxHftBR3zcKX5S5S+H5jBljCfthy1/LnD6PfIYcH7ryDunvNsMet49GHrPnn0dATI92s7AwVhbWq0s1WnhiRqGgF5NGfhRn7/uwlALVPzZfnwPKCACa7j0iPmdC33UuiZolDhEC5cC6aW7Qg3FbCJ9Tgzo0nzsXdc/W9ZT53MpRv4WEb0kIQDxpJ+2yet22BLxA9c18MutAyZkDdp74dcjt0Y65ZeGqxc" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="completed keyexchange" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="completed challenge" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=info msg="authenticated AP" username="du*******st" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=info msg="authenticated Login5" username="du*******st" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="stored credentials" username="du*******st" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="initializing zeroconf session" username="du*******st" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="dealer connection opened" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=trace msg="starting accesspoint recv loop" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=trace msg="starting dealer recv loop" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=trace msg="received accesspoint ping" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="received connection id: MTU1ODg2ZTUtNzY2...RjVGMEUzNjYyNA==" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=trace msg="received accesspoint pong ack" Apr 03 14:11:48 soundsystem go-librespot[13817]: time="2026-04-03T14:11:48-04:00" level=debug msg="put connect state because NEW_DEVICE" Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 14:11:49 soundsystem volumio[1401]: info: Received Get System Info Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 14:11:49 soundsystem volumio[1401]: info: Discovery: Getting this device information Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 03 14:11:49 soundsystem volumio[1401]: info: Received Get System Info Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 14:11:49 soundsystem volumio[1401]: info: Discovery: Getting this device information Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:49 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 14:11:50 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:50 soundsystem volumio[1401]: info: Initializing connection to go-librespot Websocket Apr 03 14:11:50 soundsystem go-librespot[13817]: time="2026-04-03T14:11:50-04:00" level=debug msg="new websocket client" Apr 03 14:11:50 soundsystem volumio[1401]: info: Connection to go-librespot Websocket established Apr 03 14:11:50 soundsystem volumio[1401]: info: go-librespot daemon successfully initialized Apr 03 14:11:51 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:53 soundsystem volumio[1401]: info: Getting Spotify volume Apr 03 14:11:53 soundsystem volumio[1401]: info: Spotify volume: 100 Apr 03 14:11:53 soundsystem volumio[1401]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Apr 03 14:11:53 soundsystem volumio[1401]: info: Initializing connection to go-librespot Websocket Apr 03 14:11:53 soundsystem go-librespot[13817]: time="2026-04-03T14:11:53-04:00" level=debug msg="new websocket client" Apr 03 14:11:53 soundsystem volumio[1401]: info: Connection to go-librespot Websocket established Apr 03 14:11:53 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:53 soundsystem volumio[1401]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Apr 03 14:11:53 soundsystem volumio[1401]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 14:11:53 soundsystem volumio[1401]: SPOTIFY: VOLUMIO VOLUME 81 Apr 03 14:11:53 soundsystem volumio[1401]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 14:11:53 soundsystem volumio[1401]: info: Setting Spotify Volume from Volumio: 81 Apr 03 14:11:55 soundsystem volumio[1401]: SPOTIFY: SETTING SPOTIFY VOLUME 81 Apr 03 14:11:55 soundsystem volumio[1401]: info: Sending Spotify command with payload to local API: /player/volume Apr 03 14:11:55 soundsystem go-librespot[13817]: time="2026-04-03T14:11:55-04:00" level=debug msg="update volume requested to 53083/65535" Apr 03 14:11:55 soundsystem go-librespot[13817]: time="2026-04-03T14:11:55-04:00" level=debug msg="put connect state because VOLUME_CHANGED" Apr 03 14:11:55 soundsystem go-librespot[13817]: time="2026-04-03T14:11:55-04:00" level=trace msg="emitting websocket event: volume" Apr 03 14:11:55 soundsystem volumio[1401]: SPOTIFY: received: {"type":"volume","data":{"value":81,"max":100}} Apr 03 14:11:55 soundsystem volumio[1401]: SPOTIFY: RECEIVED SPOTIFY VOLUME 81 Apr 03 14:11:55 soundsystem volumio[1401]: SPOTIFY: received: {"type":"volume","data":{"value":81,"max":100}} Apr 03 14:11:55 soundsystem volumio[1401]: SPOTIFY: RECEIVED SPOTIFY VOLUME 81 Apr 03 14:11:56 soundsystem volumio[1401]: info: Getting Spotify volume Apr 03 14:11:56 soundsystem volumio[1401]: info: Spotify volume: 81 Apr 03 14:11:56 soundsystem volumio[1401]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Apr 03 14:11:56 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:11:56 soundsystem volumio[1401]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Apr 03 14:11:57 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 03 14:12:00 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:00 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:12:00 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:12:01 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 03 14:12:06 soundsystem volumio[1401]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 03 14:12:06 soundsystem volumio[1401]: info: Received Get System Version Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 03 14:12:06 soundsystem volumio[1401]: info: Received Get System Info Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 03 14:12:06 soundsystem volumio[1401]: info: Discovery: Getting this device information Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:06 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 03 14:12:10 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:11 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:17 soundsystem volumio[1401]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Apr 03 14:12:17 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Apr 03 14:12:17 soundsystem volumio[1401]: info: Creating Spotify config file Apr 03 14:12:17 soundsystem volumio[1401]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 03 14:12:17 soundsystem volumio[1401]: info: Spotify config file written Apr 03 14:12:17 soundsystem sudo[13874]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 03 14:12:17 soundsystem sudo[13874]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 03 14:12:17 soundsystem volumio[1401]: info: Connection to go-librespot Websocket closed Apr 03 14:12:17 soundsystem volumio[1401]: info: Connection to go-librespot Websocket closed Apr 03 14:12:17 soundsystem systemd[1]: Stopping go-librespot-daemon.service - go-librespot Daemon... Apr 03 14:12:17 soundsystem systemd[1]: go-librespot-daemon.service: Killing process 13822 (go-librespot) with signal SIGKILL. Apr 03 14:12:17 soundsystem systemd[1]: go-librespot-daemon.service: Deactivated successfully. Apr 03 14:12:17 soundsystem systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Apr 03 14:12:17 soundsystem systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Apr 03 14:12:17 soundsystem sudo[13874]: pam_unix(sudo:session): session closed for user root Apr 03 14:12:17 soundsystem go-librespot[13876]: go-librespot daemon starting... Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="running go-librespot 0.7.1" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="app state loaded" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="api server listening on 127.0.0.1:9879" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="zeroconf server listening on port 45953" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="using avahi-daemon avahi 0.8 for mDNS service registration" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="obtained new client token: AAAn72f3rNmyZTGTEvwT7n5rEq4epNjXKmcVN81QCu53fTgHAclaGBsuhpC2lJEE0gCwhCc0IP+AsJePhEg49EiBsXNBfb9k2vVbaLsG36JvtwQNii1liDMphlBBdcNas9NI1Tk3DCWgyj2A9VF1dzAlodGGTxEU/Bb8ccXbfDM2NIg4sMhUI1nOOUf7qdSjyzdLc/y9iiEmY+qzpCueLMJqm1W7TzJBT4/S6wgKRGZVbVpTAamWcphTe9g=" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="completed keyexchange" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="completed challenge" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="authenticated AP" username="du*******st" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=info msg="authenticated Login5" username="du*******st" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="initializing zeroconf session" username="du*******st" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="dealer connection opened" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=trace msg="starting accesspoint recv loop" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=trace msg="starting dealer recv loop" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=trace msg="received accesspoint ping" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="received connection id: OWNlYTRiZWQtNTQ0...QTVBRDM2RjE4Ng==" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=trace msg="received accesspoint pong ack" Apr 03 14:12:17 soundsystem go-librespot[13878]: time="2026-04-03T14:12:17-04:00" level=debug msg="put connect state because NEW_DEVICE" Apr 03 14:12:20 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:20 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:12:20 soundsystem volumio[1401]: info: Listing playlists Apr 03 14:12:20 soundsystem volumio[1401]: info: Initializing connection to go-librespot Websocket Apr 03 14:12:20 soundsystem volumio[1401]: info: Connection to go-librespot Websocket established Apr 03 14:12:20 soundsystem go-librespot[13878]: time="2026-04-03T14:12:20-04:00" level=debug msg="new websocket client" Apr 03 14:12:20 soundsystem volumio[1401]: info: go-librespot daemon successfully initialized Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreCommandRouter::volumioPause Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreStateMachine::pause Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreStateMachine::stPlaybackTimer Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreStateMachine::servicePause Apr 03 14:12:21 soundsystem volumio[1401]: info: CoreCommandRouter::servicePause Apr 03 14:12:21 soundsystem volumio[1401]: info: Spotify Received pause Apr 03 14:12:21 soundsystem volumio[1401]: SPOTIFY: SPOTIFY PAUSE Apr 03 14:12:21 soundsystem volumio[1401]: SPOTIFY: {"status":"play","title":"One Million Lovers","artist":"The Growlers","album":"Hung At Heart","albumart":"https://i.scdn.co/image/ab67616d00001e0277c1d0a6673df34bc0777348","uri":"spotify:track:2usVEoiqi71BfnF4sOOH1T","trackType":"spotify","codec":"ogg","seek":284000,"duration":282,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2,"random":null,"repeat":null,"repeatSingle":null,"consume":false,"volume":81,"dbVolume":null,"mute":false,"disableVolumeControl":false,"stream":false,"updatedb":false,"volatile":true,"service":"spop"} Apr 03 14:12:21 soundsystem volumio[1401]: info: Sending Spotify command to local API: /player/pause Apr 03 14:12:23 soundsystem volumio[1401]: info: Getting Spotify volume Apr 03 14:12:23 soundsystem volumio[1401]: info: Spotify volume: 100 Apr 03 14:12:23 soundsystem volumio[1401]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Apr 03 14:12:23 soundsystem volumio[1401]: info: CoreCommandRouter::volumioGetState Apr 03 14:12:23 soundsystem volumio[1401]: SPOTIFY: RECEIVED VOLUMIO VOLUME 81 Apr 03 14:12:23 soundsystem volumio[1401]: SPOTIFY: SPOTIFY VOLUME 100 Apr 03 14:12:23 soundsystem volumio[1401]: SPOTIFY: VOLUMIO VOLUME 81 Apr 03 14:12:23 soundsystem volumio[1401]: SPOTIFY: DELTA VOLUME ENOUGH: true Apr 03 14:12:23 soundsystem volumio[1401]: info: Setting Spotify Volume from Volumio: 81 Apr 03 14:12:23 soundsystem volumio[1401]: info: Initializing connection to go-librespot Websocket Apr 03 14:12:23 soundsystem go-librespot[13878]: time="2026-04-03T14:12:23-04:00" level=debug msg="new websocket client" Apr 03 14:12:23 soundsystem volumio[1401]: info: Connection to go-librespot Websocket established Apr 03 14:12:23 soundsystem volumio[1401]: info: CoreCommandRouter::volumioNext Apr 03 14:12:23 soundsystem volumio[1401]: info: CoreStateMachine::next Apr 03 14:12:23 soundsystem volumio[1401]: info: Spotify next Apr 03 14:12:23 soundsystem volumio[1401]: info: Sending Spotify command to local API: /player/next Apr 03 14:12:23 soundsystem go-librespot[13878]: panic: runtime error: invalid memory address or nil pointer dereference Apr 03 14:12:23 soundsystem go-librespot[13878]: [signal SIGSEGV: segmentation violation code=0x1 addr=0x4 pc=0x6b5cd0] Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 70 gp=0x2a2e6c8 m=5 mp=0x2880008 [running]: Apr 03 14:12:23 soundsystem go-librespot[13878]: panic({0x841d88, 0xfa0250}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/panic.go:802 +0x148 fp=0x2d2b538 sp=0x2d2b4e4 pc=0xa92ec Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.panicmem(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/panic.go:262 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.sigpanic() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/signal_unix.go:925 +0x384 fp=0x2d2b568 sp=0x2d2b538 pc=0xabca4 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*AppPlayer).loadCurrentTrack(0x2a404b0, {0xa3da8c, 0x2aaa230}, 0x1, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/controls.go:308 +0x13c fp=0x2d2b720 sp=0x2d2b56c pc=0x6b5cd0 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*AppPlayer).advanceNext(0x2a404b0, {0xa3da8c, 0x2aaa230}, 0x1, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/controls.go:700 +0x4dc fp=0x2d2b7d0 sp=0x2d2b720 pc=0x6b9a84 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*AppPlayer).skipNext(0x2a404b0, {0xa3da8c, 0x2aaa230}, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/controls.go:604 +0x4e8 fp=0x2d2b86c sp=0x2d2b7d0 pc=0x6b9408 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*AppPlayer).handleApiRequest(0x2a404b0, {0xa3da1c, 0x1005090}, {{0x919857, 0x4}, {0x83ac98, 0x0}, 0x29d73c0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/player.go:475 +0x174 fp=0x2d2b9e0 sp=0x2d2b86c pc=0x6c2cac Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*AppPlayer).Run(0x2a404b0, {0xa3da1c, 0x1005090}, 0x2c14a80, 0x2c14ac0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/player.go:697 +0x5b0 fp=0x2d2bfd4 sp=0x2d2b9e0 pc=0x6c5b98 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).withAppPlayer.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:274 +0x48 fp=0x2d2bfec sp=0x2d2bfd4 pc=0x6bd9f0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2d2bfec sp=0x2d2bfec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:274 +0x46c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 1 gp=0x2802128 m=nil [select]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a15ce0 sp=0x2a15ccc pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.selectgo(0x2a15df0, 0x29abdbc, 0x0, 0x0, 0x2, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2a15d90 sp=0x2a15ce0 pc=0x85000 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve(0x282a060, 0x2a15e90) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/zeroconf/zeroconf.go:300 +0x228 fp=0x2a15e38 sp=0x2a15d90 pc=0x62f43c Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).withAppPlayer(0x28ce800, {0xa3da1c, 0x1005090}, 0x28ad8d0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:340 +0x5dc fp=0x2a15ed0 sp=0x2a15e38 pc=0x6bcc60 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).withCredentials(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:209 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).SpotifyToken(0x28ce800, {0xa3da1c, 0x1005090}, {0x289b000, 0xb}, {0x28a03c0, 0x127}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:201 +0xc0 fp=0x2a15f00 sp=0x2a15ed0 pc=0x6bc02c Apr 03 14:12:23 soundsystem go-librespot[13878]: main.main() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:620 +0x660 fp=0x2a15fa8 sp=0x2a15f00 pc=0x6bf56c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.main() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:285 +0x2f0 fp=0x2a15fec sp=0x2a15fa8 pc=0x6f390 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a15fec sp=0x2a15fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 2 gp=0x28027e8 m=nil [force gc (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97746c, 0xff8fa8, 0x11, 0xa, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2848fd4 sp=0x2848fc0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goparkunlock(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:466 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.forcegchelper() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:373 +0xe4 fp=0x2848fec sp=0x2848fd4 pc=0x6f7f4 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2848fec sp=0x2848fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.init.6 in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:361 +0x1c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 3 gp=0x2802b48 m=nil [GC sweep wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97746c, 0xff9850, 0xc, 0x9, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28497c4 sp=0x28497b0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goparkunlock(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:466 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.bgsweep(0x282e050) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgcsweep.go:323 +0x11c fp=0x28497e4 sp=0x28497c4 pc=0x5768c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcenable.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:212 +0x28 fp=0x28497ec sp=0x28497e4 pc=0x46c3c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28497ec sp=0x28497ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcenable in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:212 +0x74 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 4 gp=0x2802c68 m=nil [GC scavenge wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97746c, 0xffa170, 0xd, 0xa, 0x2) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2849fb4 sp=0x2849fa0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goparkunlock(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:466 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.(*scavengerState).park(0xffa170) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgcscavenge.go:425 +0x68 fp=0x2849fc8 sp=0x2849fb4 pc=0x54a28 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.bgscavenge(0x282e050) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgcscavenge.go:658 +0x60 fp=0x2849fe4 sp=0x2849fc8 pc=0x5516c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcenable.gowrap2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:213 +0x28 fp=0x2849fec sp=0x2849fe4 pc=0x46be8 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2849fec sp=0x2849fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcenable in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:213 +0xbc Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 18 gp=0x2882248 m=nil [GOMAXPROCS updater (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97746c, 0xff95e8, 0x12, 0xa, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28447a4 sp=0x2844790 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goparkunlock(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:466 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.updateMaxProcsGoroutine() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:6720 +0x110 fp=0x28447ec sp=0x28447a4 pc=0x7f174 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28447ec sp=0x28447ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.defaultGOMAXPROCSUpdateEnable in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:6708 +0x40 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 19 gp=0x28825a8 m=nil [finalizer wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x977314, 0x1005180, 0x10, 0xa, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2844f88 sp=0x2844f74 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.runFinalizers() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mfinal.go:210 +0x110 fp=0x2844fec sp=0x2844f88 pc=0x45888 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2844fec sp=0x2844fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.createfing in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mfinal.go:172 +0x5c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 20 gp=0x2969b08 m=nil [cleanup wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97746c, 0xffa348, 0x2e, 0xa, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28487a4 sp=0x2848790 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goparkunlock(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:466 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.(*cleanupQueue).dequeue(0xffa2e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mcleanup.go:439 +0x12c fp=0x28487c4 sp=0x28487a4 pc=0x41cb0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.runCleanups() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mcleanup.go:635 +0x7c fp=0x28487ec sp=0x28487c4 pc=0x4284c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28487ec sp=0x28487ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.(*cleanupQueue).createGs in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mcleanup.go:589 +0x124 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 23 gp=0x299cd88 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1b010, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a12cf0 sp=0x2a12cdc pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1b000, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a12d08 sp=0x2a12cf0 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1b000, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a12d1c sp=0x2a12d08 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x28a5468, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a12d30 sp=0x2a12d1c pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Accept(0x28a5450) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x2a12d78 sp=0x2a12d30 pc=0x13a800 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).accept(0x28a5450) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x2a12de0 sp=0x2a12d78 pc=0x1abc28 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*TCPListener).accept(0x28b0600) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x2a12e34 sp=0x2a12de0 pc=0x1c3554 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*TCPListener).Accept(0x28b0600) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x2a12e50 sp=0x2a12e34 pc=0x1c259c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*onceCloseListener).Accept(0x2a1c080) Apr 03 14:12:23 soundsystem go-librespot[13878]: :1 +0x34 fp=0x2a12e68 sp=0x2a12e50 pc=0x367f9c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*Server).Serve(0x2a2c008, {0xa3d218, 0x28b0600}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x2a12f00 sp=0x2a12e68 pc=0x341154 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.Serve(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2971 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve(0x289e9c0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:666 +0x974 fp=0x2a12fe4 sp=0x2a12f00 pc=0x6b17bc Apr 03 14:12:23 soundsystem go-librespot[13878]: main.NewApiServer.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:332 +0x28 fp=0x2a12fec sp=0x2a12fe4 pc=0x6b04f4 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a12fec sp=0x2a12fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by main.NewApiServer in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:332 +0x310 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 72 gp=0x299cea8 m=nil [chan receive]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9772f4, 0x28901f8, 0xe, 0x7, 0x2) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284bf40 sp=0x284bf2c pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv(0x28901c0, 0x284bfe0, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x284bf88 sp=0x284bf40 pc=0x3414c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv2(0x28901c0, 0x284bfe0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x284bf9c sp=0x284bf88 pc=0x33bf0 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).withAppPlayer.func2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:300 +0x6c fp=0x284bfec sp=0x284bf9c pc=0x6bd47c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284bfec sp=0x284bfec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:297 +0x598 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 73 gp=0x299d0e8 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1ac10, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x28465ac sp=0x2846598 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1ac00, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x28465c4 sp=0x28465ac pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1ac00, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x28465d8 sp=0x28465c4 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x297e068, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x28465ec sp=0x28465d8 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Accept(0x297e050) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:613 +0x284 fp=0x2846634 sp=0x28465ec pc=0x13a800 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).accept(0x297e050) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_unix.go:161 +0x20 fp=0x284669c sp=0x2846634 pc=0x1abc28 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*TCPListener).accept(0x29f0060) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/tcpsock_posix.go:159 +0x20 fp=0x28466f0 sp=0x284669c pc=0x1c3554 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*TCPListener).Accept(0x29f0060) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/tcpsock.go:380 +0x30 fp=0x284670c sp=0x28466f0 pc=0x1c259c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*onceCloseListener).Accept(0x2c13200) Apr 03 14:12:23 soundsystem go-librespot[13878]: :1 +0x34 fp=0x2846724 sp=0x284670c pc=0x367f9c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*Server).Serve(0x2a2d4a8, {0xa3d218, 0x29f0060}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3463 +0x2d8 fp=0x28467bc sp=0x2846724 pc=0x341154 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.Serve(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2971 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve.func2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/zeroconf/zeroconf.go:297 +0x8c fp=0x28467ec sp=0x28467bc pc=0x62f538 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28467ec sp=0x28467ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/zeroconf.(*Zeroconf).Serve in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/zeroconf/zeroconf.go:297 +0x160 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 10 gp=0x299d208 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1ae10, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a14af4 sp=0x2a14ae0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1ae00, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a14b0c sp=0x2a14af4 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1ae00, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a14b20 sp=0x2a14b0c pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x28a56e8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a14b34 sp=0x2a14b20 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x28a56d0, {0x2a5e000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2a14b7c sp=0x2a14b34 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x28a56d0, {0x2a5e000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2a14ba8 sp=0x2a14b7c pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2a081f8, {0x2a5e000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2a14bd4 sp=0x2a14ba8 pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*atLeastReader).Read(0x2ade9d0, {0x2a5e000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2a14c00 sp=0x2a14bd4 pc=0x2674c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: bytes.(*Buffer).ReadFrom(0x2a3418c, {0xa3a068, 0x2ade9d0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2a14c3c sp=0x2a14c00 pc=0x162058 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readFromUntil(0x2a34008, {0xa38fa8, 0x2a081f8}, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2a14c64 sp=0x2a14c3c pc=0x26771c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecordOrCCS(0x2a34008, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2a14dc4 sp=0x2a14c64 pc=0x264e40 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecord(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).Read(0x2a34008, {0x2913000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2a14df4 sp=0x2a14dc4 pc=0x26ac04 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).Read(0x2ced9b0, {0x28ce424, 0x9, 0x9}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x2a14e18 sp=0x2a14df4 pc=0x2b72a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa391f8, 0x2ced9b0}, {0x28ce424, 0x9, 0x9}, 0x9) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2a14e44 sp=0x2a14e18 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.http2readFrameHeader({0x28ce424, 0x9, 0x9}, {0xa391f8, 0x2ced9b0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x2a14e6c sp=0x2a14e44 pc=0x2f86ac Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Framer).ReadFrame(0x28ce400) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x2a14ef4 sp=0x2a14e6c pc=0x2f8e04 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2clientConnReadLoop).run(0x2a14fdc) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x2a14fa4 sp=0x2a14ef4 pc=0x31d33c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2ClientConn).readLoop(0x299c008) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x2a14fe4 sp=0x2a14fa4 pc=0x31c604 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x2a14fec sp=0x2a14fe4 pc=0x316960 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a14fec sp=0x2a14fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*http2Transport).newClientConn in goroutine 9 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 5 gp=0x2802fc8 m=nil [GC worker (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x977320, 0x2c1c400, 0x1c, 0xa, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284a788 sp=0x284a774 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkWorker(0x2ca4180) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x284a7e4 sp=0x284a788 pc=0x49f34 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x284a7ec sp=0x284a7e4 pc=0x49e14 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284a7ec sp=0x284a7ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 6 gp=0x28030e8 m=nil [GC worker (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x977320, 0x2c1c600, 0x1c, 0xa, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284af88 sp=0x284af74 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkWorker(0x2ca4180) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x284afe4 sp=0x284af88 pc=0x49f34 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x284afec sp=0x284afe4 pc=0x49e14 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284afec sp=0x284afec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 7 gp=0x2803208 m=nil [GC worker (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x977320, 0x2c1c800, 0x1c, 0xa, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x284b788 sp=0x284b774 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkWorker(0x2ca4180) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x284b7e4 sp=0x284b788 pc=0x49f34 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x284b7ec sp=0x284b7e4 pc=0x49e14 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x284b7ec sp=0x284b7ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 8 gp=0x2803328 m=nil [GC worker (idle)]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x977320, 0x2c1ca00, 0x1c, 0xa, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2856f88 sp=0x2856f74 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkWorker(0x2ca4180) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1463 +0xf4 fp=0x2856fe4 sp=0x2856f88 pc=0x49f34 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gcBgMarkStartWorkers.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x28 fp=0x2856fec sp=0x2856fe4 pc=0x49e14 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2856fec sp=0x2856fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by runtime.gcBgMarkStartWorkers in goroutine 34 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/mgc.go:1373 +0x14c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 29 gp=0x2803448 m=nil [chan receive]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9772f4, 0x2a16178, 0xe, 0x7, 0x2) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2845778 sp=0x2845764 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv(0x2a16140, 0x0, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x28457c0 sp=0x2845778 pc=0x3414c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv1(0x2a16140, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x28457d4 sp=0x28457c0 pc=0x33bcc Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/godbus/dbus/v5.newConn.func1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:303 +0x40 fp=0x28457ec sp=0x28457d4 pc=0x4aa8ec Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x28457ec sp=0x28457ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/godbus/dbus/v5.newConn in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:302 +0x52c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 50 gp=0x2a2e248 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1aa10, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a0ecbc sp=0x2a0eca8 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1aa00, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a0ecd4 sp=0x2a0ecbc pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1aa00, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a0ece8 sp=0x2a0ecd4 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x297e0b8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a0ecfc sp=0x2a0ece8 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).ReadMsg(0x297e0a0, {0x2b44140, 0x10, 0x10}, {0x2917918, 0x1000, 0x1000}, 0x40000000) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:295 +0x2c0 fp=0x2a0ed6c sp=0x2a0ecfc pc=0x1381bc Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).readMsg(0x297e0a0, {0x2b44140, 0x10, 0x10}, {0x2917918, 0x1000, 0x1000}, 0x40000000) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:91 +0x58 fp=0x2a0edc8 sp=0x2a0ed6c pc=0x1aa2c8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*UnixConn).readMsg(0x2a084a8, {0x2b44140, 0x10, 0x10}, {0x2917918, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/unixsock_posix.go:115 +0x58 fp=0x2a0ee28 sp=0x2a0edc8 pc=0x1c9d80 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*UnixConn).ReadMsgUnix(0x2a084a8, {0x2b44140, 0x10, 0x10}, {0x2917918, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/unixsock.go:143 +0x58 fp=0x2a0ee78 sp=0x2a0ee28 pc=0x1c820c Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/godbus/dbus/v5.(*oobReader).Read(0x2917908, {0x2b44140, 0x10, 0x10}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:41 +0x50 fp=0x2a0eec8 sp=0x2a0ee78 pc=0x4c2af0 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa39d58, 0x2917908}, {0x2b44140, 0x10, 0x10}, 0x10) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2a0eef4 sp=0x2a0eec8 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem volumio[1401]: error: Failed to send command to Spotify local API: /player/next: Error: socket hang up Apr 03 14:12:23 soundsystem volumio[1401]: info: Connection to go-librespot Websocket closed Apr 03 14:12:23 soundsystem volumio[1401]: info: Connection to go-librespot Websocket closed Apr 03 14:12:23 soundsystem systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=134/n/a Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/godbus/dbus/v5.(*unixTransport).ReadMessage(0x2b20140) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/transport_unix.go:124 +0x224 fp=0x2a0efa0 sp=0x2a0eef4 pc=0x4c32c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/godbus/dbus/v5.(*Conn).inWorker(0x2a00200) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/conn.go:390 +0x44 fp=0x2a0efe4 sp=0x2a0efa0 pc=0x4aaef4 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/godbus/dbus/v5.(*Conn).Auth.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x28 fp=0x2a0efec sp=0x2a0efe4 pc=0x4a8318 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a0efec sp=0x2a0efec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/godbus/dbus/v5.(*Conn).Auth in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/godbus/dbus/v5@v5.2.0/auth.go:118 +0x77c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 45 gp=0x2a2e5a8 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1a410, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a13af4 sp=0x2a13ae0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1a400, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a13b0c sp=0x2a13af4 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1a400, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a13b20 sp=0x2a13b0c pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2d1d4b8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a13b34 sp=0x2a13b20 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2d1d4a0, {0x2c8d000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2a13b7c sp=0x2a13b34 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2d1d4a0, {0x2c8d000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2a13ba8 sp=0x2a13b7c pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2b052d0, {0x2c8d000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2a13bd4 sp=0x2a13ba8 pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*atLeastReader).Read(0x2b1da00, {0x2c8d000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2a13c00 sp=0x2a13bd4 pc=0x2674c0 Apr 03 14:12:23 soundsystem systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Apr 03 14:12:23 soundsystem go-librespot[13878]: bytes.(*Buffer).ReadFrom(0x2d2618c, {0xa3a068, 0x2b1da00}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2a13c3c sp=0x2a13c00 pc=0x162058 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readFromUntil(0x2d26008, {0xa38fa8, 0x2b052d0}, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2a13c64 sp=0x2a13c3c pc=0x26771c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecordOrCCS(0x2d26008, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2a13dc4 sp=0x2a13c64 pc=0x264e40 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecord(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).Read(0x2d26008, {0x2d59000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2a13df4 sp=0x2a13dc4 pc=0x26ac04 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).Read(0x2d489f0, {0x2b266a4, 0x9, 0x9}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x2a13e18 sp=0x2a13df4 pc=0x2b72a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa391f8, 0x2d489f0}, {0x2b266a4, 0x9, 0x9}, 0x9) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2a13e44 sp=0x2a13e18 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.http2readFrameHeader({0x2b266a4, 0x9, 0x9}, {0xa391f8, 0x2d489f0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x2a13e6c sp=0x2a13e44 pc=0x2f86ac Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Framer).ReadFrame(0x2b26680) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x2a13ef4 sp=0x2a13e6c pc=0x2f8e04 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2clientConnReadLoop).run(0x2a13fdc) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x2a13fa4 sp=0x2a13ef4 pc=0x31d33c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2ClientConn).readLoop(0x2969c28) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x2a13fe4 sp=0x2a13fa4 pc=0x31c604 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x2a13fec sp=0x2a13fe4 pc=0x316960 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a13fec sp=0x2a13fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*http2Transport).newClientConn in goroutine 44 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 71 gp=0x28827e8 m=nil [chan receive]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9772f4, 0x2890238, 0xe, 0x7, 0x2) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2b7b73c sp=0x2b7b728 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv(0x2890200, 0x2b7b7d0, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x2b7b784 sp=0x2b7b73c pc=0x3414c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv2(0x2890200, 0x2b7b7d0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:514 +0x20 fp=0x2b7b798 sp=0x2b7b784 pc=0x33bf0 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*App).withAppPlayer.func1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:284 +0x68 fp=0x2b7b7ec sp=0x2b7b798 pc=0x6bd918 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2b7b7ec sp=0x2b7b7ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by main.(*App).withAppPlayer in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/main.go:281 +0x4f8 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 48 gp=0x2a2e7e8 m=nil [select]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2847ea4 sp=0x2847e90 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.selectgo(0x2847fd4, 0x2847f78, 0x0, 0x0, 0x2, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x2847f54 sp=0x2847ea4 pc=0x85000 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).pongAckTicker(0x2a2d348) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:368 +0x8c fp=0x2847fe4 sp=0x2847f54 pc=0x4f7cf8 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:277 +0x28 fp=0x2847fec sp=0x2847fe4 pc=0x4f73c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2847fec sp=0x2847fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 70 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:277 +0x15c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 47 gp=0x2a2ea28 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1a610, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2c07d04 sp=0x2c07cf0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1a600, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2c07d1c sp=0x2c07d04 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1a600, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2c07d30 sp=0x2c07d1c pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x287af18, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2c07d44 sp=0x2c07d30 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x287af00, {0x2813260, 0x3, 0x3}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2c07d8c sp=0x2c07d44 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x287af00, {0x2813260, 0x3, 0x3}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2c07db8 sp=0x2c07d8c pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2b041c8, {0x2813260, 0x3, 0x3}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2c07de4 sp=0x2c07db8 pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa38fa8, 0x2b041c8}, {0x2813260, 0x3, 0x3}, 0x3) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2c07e10 sp=0x2c07de4 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/ap.(*shannonConn).receivePacket(0x2a29500, {0xa3da1c, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/shannon.go:124 +0x370 fp=0x2c07ed4 sp=0x2c07e10 pc=0x4fac0c Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).recvLoop(0x2a2d348) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:289 +0x68 fp=0x2c07fe4 sp=0x2c07ed4 pc=0x4f74ac Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:273 +0x28 fp=0x2c07fec sp=0x2c07fe4 pc=0x4f7418 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2c07fec sp=0x2c07fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/ap.(*Accesspoint).Receive.(*Accesspoint).startReceiving.func1 in goroutine 70 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/ap/ap.go:273 +0x98 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 69 gp=0x2a2eb48 m=nil [select]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29a5674 sp=0x29a5660 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.selectgo(0x29a5780, 0x29a574c, 0x0, 0x0, 0x3, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x29a5724 sp=0x29a5674 pc=0x85000 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/player.(*Player).manageLoop(0x287b9a0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/player/player.go:215 +0x1f4 fp=0x29a57e4 sp=0x29a5724 pc=0x582954 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/player.NewPlayer.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/player/player.go:197 +0x28 fp=0x29a57ec sp=0x29a57e4 pc=0x58253c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29a57ec sp=0x29a57ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/player.NewPlayer in goroutine 1 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/player/player.go:197 +0x220 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 15 gp=0x2a2ec68 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1a810, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2c04af4 sp=0x2c04ae0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1a800, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2c04b0c sp=0x2c04af4 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1a800, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2c04b20 sp=0x2c04b0c pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2a41be8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2c04b34 sp=0x2c04b20 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2a41bd0, {0x2c10000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2c04b7c sp=0x2c04b34 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2a41bd0, {0x2c10000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2c04ba8 sp=0x2c04b7c pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2c83950, {0x2c10000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2c04bd4 sp=0x2c04ba8 pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*atLeastReader).Read(0x2b1c5e0, {0x2c10000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2c04c00 sp=0x2c04bd4 pc=0x2674c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: bytes.(*Buffer).ReadFrom(0x29aef0c, {0xa3a068, 0x2b1c5e0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2c04c3c sp=0x2c04c00 pc=0x162058 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readFromUntil(0x29aed88, {0xa38fa8, 0x2c83950}, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2c04c64 sp=0x2c04c3c pc=0x26771c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecordOrCCS(0x29aed88, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2c04dc4 sp=0x2c04c64 pc=0x264e40 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecord(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).Read(0x29aed88, {0x2c16000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2c04df4 sp=0x2c04dc4 pc=0x26ac04 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).Read(0x2c0ac00, {0x28ce7a4, 0x9, 0x9}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x2c04e18 sp=0x2c04df4 pc=0x2b72a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa391f8, 0x2c0ac00}, {0x28ce7a4, 0x9, 0x9}, 0x9) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2c04e44 sp=0x2c04e18 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.http2readFrameHeader({0x28ce7a4, 0x9, 0x9}, {0xa391f8, 0x2c0ac00}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x2c04e6c sp=0x2c04e44 pc=0x2f86ac Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Framer).ReadFrame(0x28ce780) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x2c04ef4 sp=0x2c04e6c pc=0x2f8e04 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2clientConnReadLoop).run(0x2c04fdc) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x2c04fa4 sp=0x2c04ef4 pc=0x31d33c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2ClientConn).readLoop(0x299c488) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x2c04fe4 sp=0x2c04fa4 pc=0x31c604 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x2c04fec sp=0x2c04fe4 pc=0x316960 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2c04fec sp=0x2c04fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*http2Transport).newClientConn in goroutine 14 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 49 gp=0x2803568 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf6e1a210, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a11998 sp=0x2a11984 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf6e1a200, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a119b0 sp=0x2a11998 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf6e1a200, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a119c4 sp=0x2a119b0 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2a41e68, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a119d8 sp=0x2a119c4 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2a41e50, {0x2abf000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2a11a20 sp=0x2a119d8 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2a41e50, {0x2abf000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2a11a4c sp=0x2a11a20 pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2c83ea0, {0x2abf000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2a11a78 sp=0x2a11a4c pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*atLeastReader).Read(0x2adfb20, {0x2abf000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2a11aa4 sp=0x2a11a78 pc=0x2674c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: bytes.(*Buffer).ReadFrom(0x29af5cc, {0xa3a068, 0x2adfb20}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2a11ae0 sp=0x2a11aa4 pc=0x162058 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readFromUntil(0x29af448, {0xa38fa8, 0x2c83ea0}, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2a11b08 sp=0x2a11ae0 pc=0x26771c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecordOrCCS(0x29af448, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2a11c68 sp=0x2a11b08 pc=0x264e40 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecord(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).Read(0x29af448, {0x2814000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2a11c98 sp=0x2a11c68 pc=0x26ac04 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*readWriteCloserBody).Read(0x2b1c010, {0x2814000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/transport.go:2578 +0xec fp=0x2a11cb8 sp=0x2a11c98 pc=0x358048 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).fill(0x2d48000) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2a11cdc sp=0x2a11cb8 pc=0x2b6c1c Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).ReadByte(0x2d48000) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2a11ce8 sp=0x2a11cdc pc=0x2b7498 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.readFrameHeader(0x2d48000, {0x290ac38, 0x8, 0x8}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x2a11d28 sp=0x2a11ce8 pc=0x372a08 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readFrameHeader(0x290ac08, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x2a11dac sp=0x2a11d28 pc=0x375bd4 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readLoop(0x290ac08, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x2a11e70 sp=0x2a11dac pc=0x375390 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).reader(0x290ac08, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x2a11ef4 sp=0x2a11e70 pc=0x376798 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Reader(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Read(0x290ac08, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x2a11f1c sp=0x2a11ef4 pc=0x374944 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/dealer.(*Dealer).recvLoop(0x2a2d3f8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:188 +0x58 fp=0x2a11fe4 sp=0x2a11f1c pc=0x5a222c Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:125 +0x28 fp=0x2a11fec sp=0x2a11fe4 pc=0x5a3d28 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a11fec sp=0x2a11fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 70 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:125 +0x98 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 82 gp=0x2803688 m=nil [select]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9774a0, 0x0, 0x9, 0x3, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29a2684 sp=0x29a2670 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.selectgo(0x29a27d4, 0x29a275c, 0x0, 0x0, 0x2, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/select.go:351 +0xc4c fp=0x29a2734 sp=0x29a2684 pc=0x85000 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/dealer.(*Dealer).pingTicker(0x2a2d3f8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:138 +0x8c fp=0x29a27e4 sp=0x29a2734 pc=0x5a1d90 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1.gowrap2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:129 +0x28 fp=0x29a27ec sp=0x29a27e4 pc=0x5a3cd4 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29a27ec sp=0x29a27ec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by github.com/devgianlu/go-librespot/dealer.(*Dealer).ReceiveMessage.(*Dealer).startReceiving.func1 in goroutine 70 Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/dealer/dealer.go:129 +0x15c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 103 gp=0x2803c28 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf64e9610, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2d2f908 sp=0x2d2f8f4 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf64e9600, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2d2f920 sp=0x2d2f908 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf64e9600, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2d2f934 sp=0x2d2f920 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2b302e8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2d2f948 sp=0x2d2f934 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2b302d0, {0x2b4b000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2d2f990 sp=0x2d2f948 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2b302d0, {0x2b4b000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2d2f9bc sp=0x2d2f990 pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2c82320, {0x2b4b000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2d2f9e8 sp=0x2d2f9bc pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: io.(*multiReader).Read(0x2b1c040, {0x2b4b000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2d2fa14 sp=0x2d2f9e8 pc=0xefb88 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).fill(0x28b1500) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2d2fa38 sp=0x2d2fa14 pc=0x2b6c1c Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).ReadByte(0x28b1500) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2d2fa44 sp=0x2d2fa38 pc=0x2b7498 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.readFrameHeader(0x28b1500, {0x29c4038, 0x8, 0x8}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x2d2fa84 sp=0x2d2fa44 pc=0x372a08 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readFrameHeader(0x29c4008, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x2d2fb08 sp=0x2d2fa84 pc=0x375bd4 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readLoop(0x29c4008, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x2d2fbcc sp=0x2d2fb08 pc=0x375390 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).reader(0x29c4008, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x2d2fc50 sp=0x2d2fbcc pc=0x376798 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Reader(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Read(0x29c4008, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x2d2fc78 sp=0x2d2fc50 pc=0x374944 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.func17({0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:636 +0x3b4 fp=0x2d2fcfc sp=0x2d2fc78 pc=0x6b2040 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a08188, {0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2d2fd0c sp=0x2d2fcfc pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*ServeMux).ServeHTTP(0x2a00000, {0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x2d2fd4c sp=0x2d2fd0c pc=0x33f6c8 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x2d2fd74 sp=0x2d2fd4c pc=0x6b19b8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a04140, {0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2d2fd84 sp=0x2d2fd74 pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.serverHandler.ServeHTTP({0x2a2c008}, {0xa3d2d8, 0x2a3c848}, 0x2a3c6e8) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x2d2fda0 sp=0x2d2fd84 pc=0x35cb44 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*conn).serve(0x289e6c0, {0xa3da38, 0x2a1a1e0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x2d2ffdc sp=0x2d2fda0 pc=0x33b894 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*Server).Serve.gowrap3() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x2d2ffec sp=0x2d2ffdc pc=0x3415cc Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2d2ffec sp=0x2d2ffec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*Server).Serve in goroutine 23 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x42c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 32 gp=0x2803d48 m=nil [chan receive]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x9772f4, 0x29d73f8, 0xe, 0x7, 0x2) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x285bbd8 sp=0x285bbc4 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv(0x29d73c0, 0x285bcac, 0x1) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:667 +0x550 fp=0x285bc20 sp=0x285bbd8 pc=0x3414c Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.chanrecv1(0x29d73c0, 0x285bcac) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/chan.go:509 +0x20 fp=0x285bc34 sp=0x285bc20 pc=0x33bcc Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).handleRequest(0x289e9c0, {{0x919857, 0x4}, {0x83ac98, 0x0}, 0x29d73c0}, {0xa3d2d8, 0x2a2d608}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:355 +0x74 fp=0x285bcbc sp=0x285bc34 pc=0x6b06a4 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.func8({0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:486 +0x12c fp=0x285bcfc sp=0x285bcbc pc=0x6b2e58 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a080a0, {0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x285bd0c sp=0x285bcfc pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*ServeMux).ServeHTTP(0x2a00000, {0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x285bd4c sp=0x285bd0c pc=0x33f6c8 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x285bd74 sp=0x285bd4c pc=0x6b19b8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a04140, {0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x285bd84 sp=0x285bd74 pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.serverHandler.ServeHTTP({0x2a2c008}, {0xa3d2d8, 0x2a2d608}, 0x2b0a848) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x285bda0 sp=0x285bd84 pc=0x35cb44 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*conn).serve(0x2b2c060, {0xa3da38, 0x2a1a1e0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x285bfdc sp=0x285bda0 pc=0x33b894 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*Server).Serve.gowrap3() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x285bfec sp=0x285bfdc pc=0x3415cc Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x285bfec sp=0x285bfec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*Server).Serve in goroutine 23 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x42c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 101 gp=0x2803e68 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf64e9810, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2a10af4 sp=0x2a10ae0 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf64e9800, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2a10b0c sp=0x2a10af4 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf64e9800, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2a10b20 sp=0x2a10b0c pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2a31e18, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2a10b34 sp=0x2a10b20 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2a31e00, {0x29ac000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2a10b7c sp=0x2a10b34 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2a31e00, {0x29ac000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2a10ba8 sp=0x2a10b7c pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2c82120, {0x29ac000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2a10bd4 sp=0x2a10ba8 pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*atLeastReader).Read(0x2810370, {0x29ac000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:816 +0x78 fp=0x2a10c00 sp=0x2a10bd4 pc=0x2674c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: bytes.(*Buffer).ReadFrom(0x29ae18c, {0xa3a068, 0x2810370}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bytes/buffer.go:217 +0xa4 fp=0x2a10c3c sp=0x2a10c00 pc=0x162058 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readFromUntil(0x29ae008, {0xa38fa8, 0x2c82120}, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:838 +0xd4 fp=0x2a10c64 sp=0x2a10c3c pc=0x26771c Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecordOrCCS(0x29ae008, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:627 +0x134 fp=0x2a10dc4 sp=0x2a10c64 pc=0x264e40 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).readRecord(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:589 Apr 03 14:12:23 soundsystem go-librespot[13878]: crypto/tls.(*Conn).Read(0x29ae008, {0x2b4a000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/crypto/tls/conn.go:1392 +0x14c fp=0x2a10df4 sp=0x2a10dc4 pc=0x26ac04 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).Read(0x28b1380, {0x2b26024, 0x9, 0x9}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:245 +0x214 fp=0x2a10e18 sp=0x2a10df4 pc=0x2b72a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadAtLeast({0xa391f8, 0x28b1380}, {0x2b26024, 0x9, 0x9}, 0x9) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:335 +0x90 fp=0x2a10e44 sp=0x2a10e18 pc=0xee954 Apr 03 14:12:23 soundsystem go-librespot[13878]: io.ReadFull(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/io.go:354 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.http2readFrameHeader({0x2b26024, 0x9, 0x9}, {0xa391f8, 0x28b1380}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:1811 +0x54 fp=0x2a10e6c sp=0x2a10e44 pc=0x2f86ac Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Framer).ReadFrame(0x2b26000) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:2078 +0x8c fp=0x2a10ef4 sp=0x2a10e6c pc=0x2f8e04 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2clientConnReadLoop).run(0x2a10fdc) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9539 +0x108 fp=0x2a10fa4 sp=0x2a10ef4 pc=0x31d33c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2ClientConn).readLoop(0x299c908) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:9408 +0x80 fp=0x2a10fe4 sp=0x2a10fa4 pc=0x31c604 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*http2Transport).newClientConn.gowrap1() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0x28 fp=0x2a10fec sp=0x2a10fe4 pc=0x316960 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2a10fec sp=0x2a10fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*http2Transport).newClientConn in goroutine 100 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/h2_bundle.go:8192 +0xee4 Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 91 gp=0x2969e68 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf64e9410, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x2ab3908 sp=0x2ab38f4 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf64e9400, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x2ab3920 sp=0x2ab3908 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf64e9400, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x2ab3934 sp=0x2ab3920 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x2aaa108, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x2ab3948 sp=0x2ab3934 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x2aaa0f0, {0x2aa0000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x2ab3990 sp=0x2ab3948 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x2aaa0f0, {0x2aa0000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x2ab39bc sp=0x2ab3990 pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x2b05648, {0x2aa0000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x2ab39e8 sp=0x2ab39bc pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: io.(*multiReader).Read(0x28ad6a0, {0x2aa0000, 0x1000, 0x1000}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/io/multi.go:26 +0xb4 fp=0x2ab3a14 sp=0x2ab39e8 pc=0xefb88 Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).fill(0x2a3f470) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:113 +0x10c fp=0x2ab3a38 sp=0x2ab3a14 pc=0x2b6c1c Apr 03 14:12:23 soundsystem go-librespot[13878]: bufio.(*Reader).ReadByte(0x2a3f470) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/bufio/bufio.go:273 +0x28 fp=0x2ab3a44 sp=0x2ab3a38 pc=0x2b7498 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.readFrameHeader(0x2a3f470, {0x290adb8, 0x8, 0x8}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/frame.go:55 +0x68 fp=0x2ab3a84 sp=0x2ab3a44 pc=0x372a08 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readFrameHeader(0x290ad88, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:266 +0xd0 fp=0x2ab3b08 sp=0x2ab3a84 pc=0x375bd4 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).readLoop(0x290ad88, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:185 +0x3c fp=0x2ab3bcc sp=0x2ab3b08 pc=0x375390 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).reader(0x290ad88, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:381 +0xec fp=0x2ab3c50 sp=0x2ab3bcc pc=0x376798 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Reader(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:36 Apr 03 14:12:23 soundsystem go-librespot[13878]: github.com/coder/websocket.(*Conn).Read(0x290ad88, {0xa3da00, 0x1005090}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/coder/websocket@v1.8.14/read.go:42 +0x30 fp=0x2ab3c78 sp=0x2ab3c50 pc=0x374944 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.func17({0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/cmd/daemon/api_server.go:636 +0x3b4 fp=0x2ab3cfc sp=0x2ab3c78 pc=0x6b2040 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a08188, {0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2ab3d0c sp=0x2ab3cfc pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*ServeMux).ServeHTTP(0x2a00000, {0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2861 +0x228 fp=0x2ab3d4c sp=0x2ab3d0c pc=0x33f6c8 Apr 03 14:12:23 soundsystem go-librespot[13878]: main.(*ConcreteApiServer).serve.(*Cors).Handler.func19({0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /src/.gocache/mod/github.com/rs/cors@v1.11.1/cors.go:289 +0x124 fp=0x2ab3d74 sp=0x2ab3d4c pc=0x6b19b8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.HandlerFunc.ServeHTTP(0x2a04140, {0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2322 +0x34 fp=0x2ab3d84 sp=0x2ab3d74 pc=0x33d7d8 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.serverHandler.ServeHTTP({0x2a2c008}, {0xa3d2d8, 0x2a2cfd8}, 0x2a2ce78) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3340 +0xe0 fp=0x2ab3da0 sp=0x2ab3d84 pc=0x35cb44 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*conn).serve(0x2a7d140, {0xa3da38, 0x2a1a1e0}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:2109 +0x794 fp=0x2ab3fdc sp=0x2ab3da0 pc=0x33b894 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*Server).Serve.gowrap3() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x38 fp=0x2ab3fec sp=0x2ab3fdc pc=0x3415cc Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x2ab3fec sp=0x2ab3fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*Server).Serve in goroutine 23 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:3493 +0x42c Apr 03 14:12:23 soundsystem go-librespot[13878]: goroutine 93 gp=0x2a2e908 m=nil [IO wait]: Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.gopark(0x97745c, 0xf64e9210, 0x2, 0x2, 0x5) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/proc.go:460 +0x104 fp=0x29a5ed8 sp=0x29a5ec4 pc=0xa97c0 Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.netpollblock(0xf64e9200, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:575 +0x100 fp=0x29a5ef0 sp=0x29a5ed8 pc=0x675a0 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.runtime_pollWait(0xf64e9200, 0x72) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/netpoll.go:351 +0x54 fp=0x29a5f04 sp=0x29a5ef0 pc=0xa8864 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).wait(0x287a1f8, 0x72, 0x0) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x30 fp=0x29a5f18 sp=0x29a5f04 pc=0x136044 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*pollDesc).waitRead(...) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_poll_runtime.go:89 Apr 03 14:12:23 soundsystem go-librespot[13878]: internal/poll.(*FD).Read(0x287a1e0, {0x2a02915, 0x1, 0x1}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/internal/poll/fd_unix.go:165 +0x22c fp=0x29a5f60 sp=0x29a5f18 pc=0x1371c4 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*netFD).Read(0x287a1e0, {0x2a02915, 0x1, 0x1}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/fd_posix.go:68 +0x38 fp=0x29a5f8c sp=0x29a5f60 pc=0x1a9e78 Apr 03 14:12:23 soundsystem go-librespot[13878]: net.(*conn).Read(0x28320c8, {0x2a02915, 0x1, 0x1}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/net.go:196 +0x48 fp=0x29a5fb8 sp=0x29a5f8c pc=0x1b967c Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*connReader).backgroundRead(0x2a02900) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:702 +0x3c fp=0x29a5fe4 sp=0x29a5fb8 pc=0x335ac0 Apr 03 14:12:23 soundsystem go-librespot[13878]: net/http.(*connReader).startBackgroundRead.gowrap2() Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:698 +0x28 fp=0x29a5fec sp=0x29a5fe4 pc=0x3359fc Apr 03 14:12:23 soundsystem go-librespot[13878]: runtime.goexit({}) Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/runtime/asm_arm.s:877 +0x4 fp=0x29a5fec sp=0x29a5fec pc=0xb0874 Apr 03 14:12:23 soundsystem go-librespot[13878]: created by net/http.(*connReader).startBackgroundRead in goroutine 32 Apr 03 14:12:23 soundsystem go-librespot[13878]: /usr/local/go/src/net/http/server.go:698 +0xd4 Apr 03 14:12:23 soundsystem go-librespot[13876]: Aborted Apr 03 14:12:24 soundsystem volumio[1401]: SPOTIFY: SETTING SPOTIFY VOLUME 81 Apr 03 14:12:24 soundsystem volumio[1401]: info: Sending Spotify command with payload to local API: /player/volume Apr 03 14:12:24 soundsystem volumio[1401]: error: Failed to send command to Spotify local API: /player/volume: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 03 14:12:26 soundsystem volumio[1401]: info: Getting Spotify volume Apr 03 14:12:26 soundsystem volumio[1401]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 14:12:26 soundsystem volumio[1401]: Error: connect ECONNREFUSED 127.0.0.1:9879 Apr 03 14:12:26 soundsystem volumio[1401]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Apr 03 14:12:26 soundsystem volumio[1401]: errno: -111, Apr 03 14:12:26 soundsystem volumio[1401]: code: 'ECONNREFUSED', Apr 03 14:12:26 soundsystem volumio[1401]: syscall: 'connect', Apr 03 14:12:26 soundsystem volumio[1401]: address: '127.0.0.1', Apr 03 14:12:26 soundsystem volumio[1401]: port: 9879, Apr 03 14:12:26 soundsystem volumio[1401]: response: undefined Apr 03 14:12:26 soundsystem volumio[1401]: } Apr 03 14:12:26 soundsystem volumio[1401]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 14:12:26 soundsystem sudo[13917]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 14:11' Apr 03 14:12:26 soundsystem sudo[13917]: 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"