-- Logs begin at Mon 2025-11-03 11:21:55 EST, end at Mon 2025-11-03 12:08:02 EST. -- Nov 03 12:07:00 rivoplus volumio-remote-updater[2847]: [2025-11-03 12:07:00] [connect] Successful connection Nov 03 12:07:15 rivoplus volumio-remote-updater[2847]: [2025-11-03 12:07:15] [connect] Successful connection Nov 03 12:07:15 rivoplus volumio[7021]: info: Executing endpoint metavolumio Nov 03 12:07:15 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 03 12:07:15 rivoplus volumio[7021]: info: Executing endpoint metavolumio Nov 03 12:07:15 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Nov 03 12:07:15 rivoplus volumio[7021]: info: Executing endpoint qc_getconfig Nov 03 12:07:15 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.657 [7289.7289] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.666 [7289.7289] INFO VolumeManager: [0xac994b10]: Setting new playback volume: 75 Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.666 [7289.7289] INFO VolumeManager: [0xac994b10]: Setting new mute state: 0 Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.666 [7289.7289] INFO QobuzConnect: [0xac9954e0]: Client initialized! Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.666 [7289.7289] INFO SampleApp: Starting Avahi advertising, name: Rivoplus, service name: _qobuz-connect._tcp Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.682 [7289.7289] INFO LocalConfigManager: [0xac9943f0]: Starting Local Configuration server Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.682 [7289.7289] INFO SampleApp: Starting Local configuration server Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.683 [7289.7289] INFO SampleApp: Connected to UNIX socket client 0xac989ed8 Nov 03 12:07:15 rivoplus volumio[7021]: info: Touch Event Listener Process Closed Nov 03 12:07:15 rivoplus volumio[7021]: error: Cannot start Volumio Streaming Daemon Nov 03 12:07:15 rivoplus volumio[7021]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 03 12:07:15 rivoplus volumio[7021]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 03 12:07:15 rivoplus volumio[7021]: info: Bluetooth name changed to Rivoplus Nov 03 12:07:15 rivoplus volumio[7021]: info: MPD Permissions set Nov 03 12:07:15 rivoplus volumio[7021]: info: MPD Permissions set Nov 03 12:07:15 rivoplus qobuz-connect[7289]: 20251103 12:07:15.807 [7289.7289] INFO SampleApp: Playback volume changed: 75 Nov 03 12:07:15 rivoplus volumio[7021]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 03 12:07:15 rivoplus volumio[7021]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Nov 03 12:07:15 rivoplus volumio[7021]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Nov 03 12:07:15 rivoplus volumio[7021]: info: camilladsp spawned new process with pid 7472, instance 1, run: true Nov 03 12:07:15 rivoplus volumio[7021]: info: camilladsp service started and running in background, instance 1 Nov 03 12:07:15 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: cannot open device 'volumioHw': Device or resource busy Nov 03 12:07:16 rivoplus volumio[7021]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Nov 03 12:07:16 rivoplus volumio[7021]: cannot open device 'volumioHw': Device or resource busy Nov 03 12:07:16 rivoplus volumio[7021]: info: FusionDsp loaded Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 12:07:16 rivoplus sudo[7482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 03 12:07:16 rivoplus sudo[7482]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 12:07:16 rivoplus volumio[7021]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 03 12:07:16 rivoplus volumio[7021]: info: Adding Signal Path Element [object Object] Nov 03 12:07:16 rivoplus volumio[7021]: info: Adding fusiondspeq DSP Signal Path Element Nov 03 12:07:16 rivoplus volumio[7021]: info: Additional DSP elements updated Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: info: Updating RAAT Signal Path Nov 03 12:07:16 rivoplus volumio[7021]: info: FusionDsp - ---- installed callbackRead Nov 03 12:07:16 rivoplus sudo[7482]: pam_unix(sudo:session): session closed for user root Nov 03 12:07:16 rivoplus volumio[7021]: error: FusionDsp - File size not found in array! Nov 03 12:07:16 rivoplus volumio[7021]: info: FusionDsp - Nulleq applied Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Getting audio outputs on start Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Requesting all other devices output Nov 03 12:07:16 rivoplus sudo[7485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Nov 03 12:07:16 rivoplus sudo[7485]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 12:07:16 rivoplus sudo[7485]: pam_unix(sudo:session): session closed for user root Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 12:07:16 rivoplus volumio[7021]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Nov 03 12:07:16 rivoplus volumio[7021]: error: Plugin music_service tidalconnect failed to complete 'onStart' in a timely fashion Nov 03 12:07:16 rivoplus volumio[7021]: error: Plugin audio_interface multiroom failed to complete 'onStart' in a timely fashion Nov 03 12:07:16 rivoplus volumio[7021]: info: ------------------------------------------- Nov 03 12:07:16 rivoplus volumio[7021]: info: ----- MyVolumio plugins startup ---- Nov 03 12:07:16 rivoplus volumio[7021]: info: ------------------------------------------- Nov 03 12:07:16 rivoplus volumio[7021]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 03 12:07:16 rivoplus volumio[7021]: info: MCU Signalled Sleep Mode Active Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Nov 03 12:07:16 rivoplus volumio[7021]: info: Setting Device Volume Override Nov 03 12:07:16 rivoplus sudo[7490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force off Nov 03 12:07:16 rivoplus sudo[7490]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 12:07:16 rivoplus sudo[7490]: pam_unix(sudo:session): session closed for user root Nov 03 12:07:16 rivoplus volumio[7021]: xcb_connection_has_error() returned true Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 03 12:07:16 rivoplus volumio[7021]: info: Updating Volume Controller Parameters: Device: 5 Name: DENAFRIPS USB HiRes Audio Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 03 12:07:16 rivoplus volumio[7021]: info: Disabling external Volume Control Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreStateMachine::pushState Nov 03 12:07:16 rivoplus volumio[7021]: info: CorePlayQueue::getTrack 0 Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::volumioPushState Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::volumioGetState Nov 03 12:07:16 rivoplus volumio[7021]: info: CorePlayQueue::getTrack 0 Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Pushing multiroomSync output update for this device Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Pushing multiroomSync output Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreStateMachine::pushState Nov 03 12:07:16 rivoplus volumio[7021]: info: CorePlayQueue::getTrack 0 Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::volumioPushState Nov 03 12:07:16 rivoplus volumio[7021]: info: CoreCommandRouter::volumioGetState Nov 03 12:07:16 rivoplus volumio[7021]: info: CorePlayQueue::getTrack 0 Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Pushing multiroomSync output update for this device Nov 03 12:07:16 rivoplus volumio[7021]: info: MRS: Pushing multiroomSync output Nov 03 12:07:30 rivoplus volumio-remote-updater[2847]: [2025-11-03 12:07:30] [connect] Successful connection Nov 03 12:07:45 rivoplus volumio-remote-updater[2847]: [2025-11-03 12:07:45] [connect] Successful connection Nov 03 12:07:46 rivoplus dbus-daemon[2853]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30029ms) Nov 03 12:07:46 rivoplus dbus-daemon[2853]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30025ms) Nov 03 12:08:00 rivoplus volumio-remote-updater[2847]: [2025-11-03 12:08:00] [connect] Successful connection Nov 03 12:08:01 rivoplus volumio[7021]: info: Checking for updated MCU Firmware Nov 03 12:08:01 rivoplus volumio[7021]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 12:08:01 rivoplus volumio[7021]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Nov 03 12:08:01 rivoplus volumio[7021]: info: QobuzConnect: QOBUZ Connect daemon connected Nov 03 12:08:01 rivoplus volumio[7021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 12:08:01 rivoplus volumio[7021]: Error: write EPIPE Nov 03 12:08:01 rivoplus volumio[7021]: at afterWriteDispatched (internal/stream_base_commons.js:156:25) Nov 03 12:08:01 rivoplus volumio[7021]: at writeGeneric (internal/stream_base_commons.js:147:3) Nov 03 12:08:01 rivoplus volumio[7021]: at Socket._writeGeneric (net.js:798:11) Nov 03 12:08:01 rivoplus volumio[7021]: at Socket.connect (net.js:780:12) Nov 03 12:08:01 rivoplus volumio[7021]: at Object.onceWrapper (events.js:519:28) Nov 03 12:08:01 rivoplus volumio[7021]: at Socket.emit (events.js:412:35) Nov 03 12:08:01 rivoplus volumio[7021]: at PipeConnectWrap.afterConnect [as oncomplete] (net.js:1145:10) { Nov 03 12:08:01 rivoplus volumio[7021]: errno: -32, Nov 03 12:08:01 rivoplus volumio[7021]: code: 'EPIPE', Nov 03 12:08:01 rivoplus volumio[7021]: syscall: 'write' Nov 03 12:08:01 rivoplus volumio[7021]: } Nov 03 12:08:01 rivoplus volumio[7021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 12:08:02 rivoplus sudo[7621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-03 12:07 Nov 03 12:08:02 rivoplus sudo[7621]: 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"