Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreCommandRouter::volumioRandom Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreCommandRouter::writePlayerControls Oct 02 21:19:37 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreStateMachine::setRandom false Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreStateMachine::pushState Oct 02 21:19:37 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreCommandRouter::volumioPushState Oct 02 21:19:37 rivoplus volumio[3260]: info: CoreCommandRouter::volumioGetState Oct 02 21:19:37 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:37 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output update for this device Oct 02 21:19:37 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output Oct 02 21:19:37 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:37.309-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" state=STATUS_PLAYING positionMs=523889 volume=0 Oct 02 21:19:37 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:37.310-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" id="mnt/USB/Crucial_X9/Classical/Hilary Hahn/Hilary Hahn - The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1/01 Hilary Hahn - Violin Concerto in E minor, Op. 64; 1. Allegro molto appassiona.flac" title="Violin Concerto in E minor, op. 64: I. Allegro molto appassionato" Oct 02 21:19:37 rivoplus volumio[3260]: info: Signalling Playback active due to playback status change Oct 02 21:19:37 rivoplus volumio[3260]: info: Updating RAAT Signal Path Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::volumioPause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::pause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::servicePause Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::servicePause Oct 02 21:19:50 rivoplus volumio[3260]: info: ControllerMpd::pause Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::sendMpdCommand pause Oct 02 21:19:50 rivoplus volumio[3260]: info: Oct 02 21:19:50 rivoplus volumio[3260]: ---------------------------- MPD announces state update: player Oct 02 21:19:50 rivoplus volumio[3260]: info: sendMpdCommand pause took 5 milliseconds Oct 02 21:19:50 rivoplus volumio[3260]: info: ControllerMpd::getState Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:19:50 rivoplus volumio[3260]: info: Oct 02 21:19:50 rivoplus volumio[3260]: ---------------------------- MPD announces state update: player Oct 02 21:19:50 rivoplus volumio[3260]: info: ControllerMpd::getState Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::sendMpdCommand status Oct 02 21:19:50 rivoplus volumio[3260]: info: sendMpdCommand status took 4 milliseconds Oct 02 21:19:50 rivoplus volumio[3260]: info: sendMpdCommand status took 2 milliseconds Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::parseState Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::parseState Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 02 21:19:50 rivoplus volumio[3260]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 02 21:19:50 rivoplus volumio[3260]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:19:50 rivoplus volumio[3260]: verbose: ControllerMpd::parseTrackInfo Oct 02 21:19:50 rivoplus volumio[3260]: info: ControllerMpd::pushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::servicePushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":538030,"duration":721,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"543 Kbps","isStreaming":false,"title":"Violin Concerto in E minor, op. 64: I. Allegro molto appassionato","artist":"Felix Mendelssohn","album":"The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1","uri":"USB/Crucial_X9/Classical/Hilary Hahn/Hilary Hahn - The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1/01 Hilary Hahn - Violin Concerto in E minor, Op. 64; 1. Allegro molto appassiona.flac","trackType":"flac"} Oct 02 21:19:50 rivoplus volumio[3260]: verbose: CURRENT POSITION 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::syncState stateService pause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::syncState currentStatus pause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::pushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::volumioPushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::volumioGetState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output update for this device Oct 02 21:19:50 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:19:50 rivoplus volumio[3260]: info: ControllerMpd::pushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::servicePushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":538030,"duration":721,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"543 Kbps","isStreaming":false,"title":"Violin Concerto in E minor, op. 64: I. Allegro molto appassionato","artist":"Felix Mendelssohn","album":"The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1","uri":"USB/Crucial_X9/Classical/Hilary Hahn/Hilary Hahn - The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1/01 Hilary Hahn - Violin Concerto in E minor, Op. 64; 1. Allegro molto appassiona.flac","trackType":"flac"} Oct 02 21:19:50 rivoplus volumio[3260]: verbose: CURRENT POSITION 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::syncState stateService pause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::syncState currentStatus pause Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::pushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::volumioPushState Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreCommandRouter::volumioGetState Oct 02 21:19:50 rivoplus volumio[3260]: info: CorePlayQueue::getTrack 0 Oct 02 21:19:50 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output update for this device Oct 02 21:19:50 rivoplus volumio[3260]: info: MRS: Pushing multiroomSync output Oct 02 21:19:50 rivoplus volumio[3260]: info: CoreStateMachine::stPlaybackTimer Oct 02 21:19:50 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:50.984-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" state=STATUS_PAUSED positionMs=537662 volume=0 Oct 02 21:19:50 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:50.985-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" id="mnt/USB/Crucial_X9/Classical/Hilary Hahn/Hilary Hahn - The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1/01 Hilary Hahn - Violin Concerto in E minor, Op. 64; 1. Allegro molto appassiona.flac" title="Violin Concerto in E minor, op. 64: I. Allegro molto appassionato" Oct 02 21:19:50 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:50.987-07:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" state=STATUS_PAUSED positionMs=537662 volume=0 Oct 02 21:19:50 rivoplus volumio5-onboarding[5785]: time=2026-10-02T21:19:50.988-07:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.67:50491,00:00:00:00:00:00%01 @ 0x1dd2540" id="mnt/USB/Crucial_X9/Classical/Hilary Hahn/Hilary Hahn - The Complete Sony Recordings(CD5); Mendelssohn; Violin Concerto; Shostakovich; Violin Concerto No. 1/01 Hilary Hahn - Violin Concerto in E minor, Op. 64; 1. Allegro molto appassiona.flac" title="Violin Concerto in E minor, op. 64: I. Allegro molto appassionato" Oct 02 21:19:50 rivoplus volumio[3260]: info: ------------------------------ 40ms Oct 02 21:19:50 rivoplus volumio[3260]: info: ------------------------------ 38ms Oct 02 21:19:51 rivoplus volumio[3260]: info: Updating RAAT Signal Path Oct 02 21:19:51 rivoplus volumio[3260]: info: Updating RAAT Signal Path Oct 02 21:19:51 rivoplus volumio[3260]: info: MCU Signalled Playback Inactive Oct 02 21:20:27 rivoplus systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 02 21:20:28 rivoplus systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 02 21:20:28 rivoplus systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 02 21:20:47 rivoplus volumio[3260]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Oct 02 21:20:47 rivoplus volumio[3260]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 21:20:47 rivoplus volumio[3260]: TypeError: Cannot read properties of undefined (reading 'then') Oct 02 21:20:47 rivoplus volumio[3260]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Oct 02 21:20:47 rivoplus volumio[3260]: at Socket.emit (node:events:514:28) Oct 02 21:20:47 rivoplus volumio[3260]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 02 21:20:47 rivoplus volumio[3260]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 02 21:20:47 rivoplus volumio[3260]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 21:20:47 rivoplus sudo[8702]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 21:19' Oct 02 21:20:47 rivoplus sudo[8702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:52:40 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="ba37532a86808e19439a6278b2d45f47"