-- Logs begin at Sun 2025-10-26 20:24:43 EDT, end at Mon 2025-10-27 04:29:25 EDT. -- Oct 27 04:29:22 rivoplus ntpd[4684]: receive: Unexpected origin timestamp 0xeca93ad9.925874ea does not match aorg 0000000000.00000000 from server@172.232.28.194 xmt 0xeca9abe2.cb369ac0 Oct 27 04:29:22 rivoplus ntpd[4684]: receive: Unexpected origin timestamp 0xeca93ad9.924f9b9f does not match aorg 0000000000.00000000 from server@50.117.3.52 xmt 0xeca9abe2.cb522d34 Oct 27 04:29:22 rivoplus systemd[1]: Starting Daily man-db regeneration... Oct 27 04:29:22 rivoplus ntpd[4684]: receive: Unexpected origin timestamp 0xeca93ad9.92440cd9 does not match aorg 0000000000.00000000 from server@23.143.196.199 xmt 0xeca9abe2.d10fefe8 Oct 27 04:29:22 rivoplus volumio[3121]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 27 04:29:22 rivoplus volumio[3121]: error: MyVolumio Custom Token format not valid, refreshing it Oct 27 04:29:23 rivoplus systemd[1]: man-db.service: Succeeded. Oct 27 04:29:23 rivoplus systemd[1]: Started Daily man-db regeneration. Oct 27 04:29:23 rivoplus volumio[3121]: info: MyVolumio login type: Token Oct 27 04:29:24 rivoplus volumio[3121]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 27 04:29:24 rivoplus volumio[3121]: info: MyVolumio token set successfully Oct 27 04:29:24 rivoplus volumio[3121]: info: MYVOLUMIO: Adding device Oct 27 04:29:24 rivoplus volumio[3121]: info: MYVOLUMIO: Evaluating Server Oct 27 04:29:24 rivoplus volumio-time-update[2831]: volumio-time-update-util: Fetching time from Volumio... Oct 27 04:29:25 rivoplus volumio-time-update[2831]: volumio-time-update-util: Setting system time to: 2025-10-27 04:29:25 Oct 27 04:29:25 rivoplus sudo[4771]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-10-27 04:29:25 Oct 27 04:29:25 rivoplus sudo[4771]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 04:29:25 rivoplus volumio[3121]: info: MyVolumio status changed Oct 27 04:29:25 rivoplus volumio[3121]: info: Streaming services startup Oct 27 04:29:25 rivoplus volumio[3121]: info: Starting Streaming Daemon Oct 27 04:29:25 rivoplus dbus-daemon[2856]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.51' (uid=0 pid=4773 comm="timedatectl set-time 2025-10-27 04:29:25 " label="kernel") Oct 27 04:29:25 rivoplus volumio[3121]: info: Removing browser output: myVolumio user plan is not superstar Oct 27 04:29:25 rivoplus volumio[3121]: info: Removing audio output: Oct 27 04:29:25 rivoplus volumio[3121]: info: Stoppping Tunnel 1 Oct 27 04:29:25 rivoplus systemd[1]: Starting Time & Date Service... Oct 27 04:29:25 rivoplus sudo[4777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 27 04:29:25 rivoplus sudo[4777]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 04:29:25 rivoplus sudo[4777]: pam_unix(sudo:session): session closed for user root Oct 27 04:29:25 rivoplus sudo[4781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Oct 27 04:29:25 rivoplus sudo[4781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 04:29:25 rivoplus volumio[3121]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 27 04:29:25 rivoplus volumio[3121]: error: Cannot start Volumio Streaming Daemon Oct 27 04:29:25 rivoplus volumio[3121]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 27 04:29:25 rivoplus volumio[3121]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 27 04:29:25 rivoplus volumio[3121]: info: Discovery: A device disappeared from network Oct 27 04:29:25 rivoplus volumio[3121]: info: Discovery: Device rivoplus disappeared from network Oct 27 04:29:25 rivoplus sudo[4781]: pam_unix(sudo:session): session closed for user root Oct 27 04:29:25 rivoplus volumio[3121]: info: Remote SSH Stopped Oct 27 04:29:25 rivoplus volumio[3121]: info: Discovery: adding 109f544d-a93f-4c4b-b519-c2a0e6685c0d Oct 27 04:29:25 rivoplus volumio[3121]: info: Discovery: Found device Rivoplus Oct 27 04:29:25 rivoplus volumio[3121]: info: CoreCommandRouter::volumioGetState Oct 27 04:29:25 rivoplus volumio[3121]: info: CorePlayQueue::getTrack 0 Oct 27 04:29:25 rivoplus dbus-daemon[2856]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 27 04:29:25 rivoplus systemd[1]: Started Time & Date Service. Oct 27 04:29:25 rivoplus systemd-timedated[4778]: Changed local time to Mon Oct 27 04:29:25 2025 Oct 27 04:29:25 rivoplus sudo[4771]: pam_unix(sudo:session): session closed for user root Oct 27 04:29:25 rivoplus volumio[3121]: error: Failed to ping endpoint as1.myvolumio.org : unknown error Oct 27 04:29:25 rivoplus volumio-time-update[2831]: volumio-time-update-util: System time updated successfully. Oct 27 04:29:25 rivoplus systemd[1]: Started Volumio Time Update Utility. Oct 27 04:29:25 rivoplus volumio[3121]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 04:29:25 rivoplus systemd[1]: Reached target Multi-User System. Oct 27 04:29:25 rivoplus systemd[1]: Reached target Graphical Interface. Oct 27 04:29:25 rivoplus volumio[3121]: Error: Unable to resolve or reject the same promise twice Oct 27 04:29:25 rivoplus volumio[3121]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 27 04:29:25 rivoplus volumio[3121]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Oct 27 04:29:25 rivoplus volumio[3121]: at Socket.emit (events.js:412:35) Oct 27 04:29:25 rivoplus volumio[3121]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 27 04:29:25 rivoplus volumio[3121]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 27 04:29:25 rivoplus volumio[3121]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 04:29:25 rivoplus systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 27 04:29:25 rivoplus systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 27 04:29:25 rivoplus systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 27 04:29:25 rivoplus systemd[1]: Startup finished in 13.009s (kernel) + 2min 26.071s (userspace) = 2min 39.081s. Oct 27 04:29:25 rivoplus sudo[4796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 04:28 Oct 27 04:29:25 rivoplus sudo[4796]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"