-- Logs begin at Sat 2025-06-21 10:11:35 CEST, end at Sat 2025-06-21 23:13:51 CEST. -- Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.1.157:54002->34.158.1.133:4070: read: connection reset by peer" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="connected to ap-gew4.spotify.com:443" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="completed keyexchange" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="completed challenge" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=trace msg="received dealer pong" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=info msg="authenticated AP as k03wnv6ryaudmm7twqb8bp73o" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="re-established accesspoint connection" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=trace msg="received accesspoint ping" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jun 21 23:12:10 integro go-librespot[4038]: time="2025-06-21T23:12:10+02:00" level=trace msg="received accesspoint pong ack" Jun 21 23:12:23 integro go-librespot[4038]: time="2025-06-21T23:12:23+02:00" level=trace msg="sent dealer ping" Jun 21 23:12:53 integro go-librespot[4038]: time="2025-06-21T23:12:53+02:00" level=error msg="did not receive last pong from dealer, 43s passed" Jun 21 23:12:54 integro go-librespot[4038]: time="2025-06-21T23:12:54+02:00" level=error msg="failed receiving dealer message" error="failed to read: WebSocket closed: sent close frame: status = StatusServiceRestart and reason = \"\"" Jun 21 23:12:55 integro go-librespot[4038]: time="2025-06-21T23:12:55+02:00" level=debug msg="dealer connection opened" Jun 21 23:12:55 integro go-librespot[4038]: time="2025-06-21T23:12:55+02:00" level=debug msg="re-established dealer connection" Jun 21 23:12:55 integro go-librespot[4038]: time="2025-06-21T23:12:55+02:00" level=debug msg="received connection id: NTljMTM3NmUtOGRlZC00NWU5LTg2ODAtYTJiNzkwOTczZGYxK2RlYWxlcit0Y3A6Ly8wYWNhNDFjMS5pcC5nZXcxLnNwb3RpZnkubmV0OjU3MDArRkNCNjA0QkU0QzE0NUYyMThGQTRGNjkyNEU2NEJBM0UwQTI3RDNFOTg1NTAyNTNGODQwRUIxQzVDRkZBNEQyRQ==" Jun 21 23:12:55 integro go-librespot[4038]: time="2025-06-21T23:12:55+02:00" level=debug msg="put connect state because NEW_DEVICE" Jun 21 23:13:23 integro go-librespot[4038]: time="2025-06-21T23:13:23+02:00" level=trace msg="sent dealer ping" Jun 21 23:13:49 integro go-librespot[4038]: time="2025-06-21T23:13:49+02:00" level=trace msg="received dealer pong" Jun 21 23:13:51 integro volumio[3260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:13:51 integro volumio[3260]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Jun 21 23:13:51 integro volumio[3260]: code: 'auth/network-request-failed', Jun 21 23:13:51 integro volumio[3260]: a: null Jun 21 23:13:51 integro volumio[3260]: } Jun 21 23:13:51 integro volumio[3260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 21 23:13:51 integro sudo[28889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-21 23:12 Jun 21 23:13:51 integro sudo[28889]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="integro" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 07:15:43 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Integro" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Integro" VOLUMIO_HASH="f2ea6fc36c3df7c3e2db25c5fbfad88c"