-- Logs begin at Mon 2026-07-20 00:58:47 CEST, end at Sat 2026-08-29 22:53:40 CEST. -- Aug 29 22:53:02 rivoplus vtcs[3479]: [close:85] Entering Aug 29 22:53:02 rivoplus volumio[3102]: info: Pushing metadata Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::servicePushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreStateMachine::pushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioPushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioGetState Aug 29 22:53:02 rivoplus vtcs[3479]: [feedThread:276] Exiting Aug 29 22:53:02 rivoplus vtcs[3479]: [close:100] Exiting Aug 29 22:53:02 rivoplus vtcs[3479]: [close:85] Entering Aug 29 22:53:02 rivoplus vtcs[3479]: [close:100] Exiting Aug 29 22:53:02 rivoplus vtcs[3479]: [open:50] Opening with sample rate: 44100, type: 3 Aug 29 22:53:02 rivoplus vtcs[3479]: [start:106] Entering Aug 29 22:53:02 rivoplus vtcs[3479]: [start:113] Reopening PCM device... Aug 29 22:53:02 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:02.336+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0x33ae9f0" state=STATUS_PLAYING positionMs=287660 volume=79 Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::servicePushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreStateMachine::pushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioPushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioGetState Aug 29 22:53:02 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:02.356+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0x33ae9f0" state=STATUS_PLAYING positionMs=287660 volume=79 Aug 29 22:53:02 rivoplus vtcs[3479]: [start:115] PCM opened successfully. Aug 29 22:53:02 rivoplus vtcs[3479]: [start:120] Exiting Aug 29 22:53:02 rivoplus vtcs[3479]: [feedThread:223] Entering Aug 29 22:53:02 rivoplus volumio[3102]: info: Signalling Playback active due to playback status change Aug 29 22:53:02 rivoplus volumio[3102]: info: Signalling Playback active due to playback status change Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::servicePushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreStateMachine::pushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioPushState Aug 29 22:53:02 rivoplus volumio[3102]: info: CoreCommandRouter::volumioGetState Aug 29 22:53:02 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:02.390+02:00 level=INFO msg="emitting player state changed event" component=server peer="00:00:00:00:00:00%01 @ 0x33ae9f0" state=STATUS_PLAYING positionMs=0 volume=79 Aug 29 22:53:02 rivoplus volumio[3102]: info: Signalling Playback active due to playback status change Aug 29 22:53:05 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:05.644+02:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn Aug 29 22:53:05 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:05.645+02:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%01 @ 0x33ae9f0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Aug 29 22:53:08 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:08.950+02:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn Aug 29 22:53:08 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:08.953+02:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%01 @ 0x33ae9f0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Aug 29 22:53:12 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:12.259+02:00 level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn Aug 29 22:53:12 rivoplus volumio5-onboarding[3323]: time=2026-08-29T22:53:12.261+02:00 level=ERROR msg="failed to send event" component=server dst="00:00:00:00:00:00%01 @ 0x33ae9f0" event=SERVER_EVENT_TYPE_PLAYER_STATE_CHANGED error="peer is gone" Aug 29 22:53:39 rivoplus volumio[3102]: info: CorePlayQueue::getTrack 108 Aug 29 22:53:39 rivoplus volumio[3102]: info: CorePlayQueue::getTrack 109 Aug 29 22:53:39 rivoplus volumio[3102]: info: Prefetching next song Aug 29 22:53:39 rivoplus volumio[3102]: info: [1788036819921] ControllerTidal::prefetch Aug 29 22:53:39 rivoplus volumio[3102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 22:53:39 rivoplus volumio[3102]: TypeError: Cannot read property 'highestSoundQuality' of undefined Aug 29 22:53:39 rivoplus volumio[3102]: at ControllerTidal.getProperSoundQuality (/volumio/app/plugins/music_service/tidal/tidal_real:1:19583) Aug 29 22:53:39 rivoplus volumio[3102]: at ControllerTidal.prefetch (/volumio/app/plugins/music_service/tidal/tidal_real:1:20287) Aug 29 22:53:39 rivoplus volumio[3102]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:464:18) Aug 29 22:53:39 rivoplus volumio[3102]: at listOnTimeout (internal/timers.js:557:17) Aug 29 22:53:39 rivoplus volumio[3102]: at processTimers (internal/timers.js:500:7) Aug 29 22:53:39 rivoplus volumio[3102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 22:53:40 rivoplus sudo[23233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-29 22:52 Aug 29 22:53:40 rivoplus sudo[23233]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:19:27 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="a7285124ffc88c43265bb2db03526f6a"