-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2026-03-29 16:16:08 CEST. -- Mar 29 16:16:08 raspi systemd-timedated[1729]: Changed local time to Sun Mar 29 16:16:08 2026 Mar 29 16:16:08 raspi sudo[1722]: pam_unix(sudo:session): session closed for user root Mar 29 16:16:08 raspi volumio[877]: info: Discovery: A device disappeared from network Mar 29 16:16:08 raspi volumio-time-update[618]: volumio-time-update-util: System time updated successfully. Mar 29 16:16:08 raspi volumio[877]: info: Discovery: A device disappeared from network Mar 29 16:16:08 raspi volumio[877]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Mar 29 16:16:08 raspi volumio[877]: info: Setting Geolocation for MyVolumio to eu2 Mar 29 16:16:08 raspi volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 16:16:08 raspi volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 16:16:08 raspi volumio[877]: Error: Unable to resolve or reject the same promise twice Mar 29 16:16:08 raspi volumio[877]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 29 16:16:08 raspi volumio[877]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Mar 29 16:16:08 raspi volumio[877]: at Socket.emit (events.js:327:22) Mar 29 16:16:08 raspi volumio[877]: at endReadableNT (internal/streams/readable.js:1327:12) Mar 29 16:16:08 raspi volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 29 16:16:08 raspi volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 16:16:08 raspi systemd[1]: Starting Daily apt download activities... Mar 29 16:16:08 raspi systemd[1]: Started Volumio Time Update Utility. Mar 29 16:16:08 raspi systemd[1]: Reached target Multi-User System. Mar 29 16:16:08 raspi systemd[1]: Reached target Graphical Interface. Mar 29 16:16:08 raspi systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 29 16:16:08 raspi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 29 16:16:08 raspi systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=info msg="zeroconf server listening on port 33985" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="obtained new client token: AAAyR6Rv2xZamoeiaFgqRzYUc5xYVvX41mssmN4qMv+mE0ZUs16comXGcNvhLM60QI+DpgCv3dE6V63LVQ5qKUr95LGWsvA6XKpvchdQQZEUhxdRY0LhFdW60QsmC4V08sur5VSrQsqbvgKgptld1i+fjhNkpWzQAVM7NfBCeToZs3tiOtchHPBl7Bk6dmpjgykFLHMXLEsX2PHCh+NwvXfcIL5VzI2DGCDOHKEqBHiaBu2WE/W540U73Q==" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="connected to ap-gew1.spotify.com:4070" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="completed keyexchange" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="completed challenge" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=info msg="authenticated AP" username="3e*********************0u" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=info msg="authenticated Login5" username="3e*********************0u" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="initializing zeroconf session" username="3e*********************0u" Mar 29 16:16:08 raspi sudo[1790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-29 16:15 Mar 29 16:16:08 raspi sudo[1790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="dealer connection opened" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=trace msg="starting accesspoint recv loop" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=trace msg="starting dealer recv loop" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=trace msg="received accesspoint ping" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="received connection id: NzUzODU2Y2UtNjk2...NEVGNUU4MzhEMA==" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Mar 29 16:16:08 raspi go-librespot[1740]: time="2026-03-29T16:16:08+02:00" level=trace msg="received accesspoint pong ack" PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"