Oct 14 12:22:07 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:07 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:07 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:07 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.014Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=41 Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.015Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:08 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.094Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=41 Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.095Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:08 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:08 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Debounce: emitting confirmed playback=false for 79:33:E1:38:3C:7C (player.Status=paused, after 800ms) Oct 14 12:22:08 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [dbus-next] Playback state changed: false from 79:33:E1:38:3C:7C Oct 14 12:22:08 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Received pause signal from winner, scheduling idle check Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:08 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:08 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.794Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=41 Oct 14 12:22:08 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:08.795Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:08 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:08 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:10 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:10 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:307: Closing BT socket duplicate [15]: 16 Oct 14 12:22:10 rivoplus bluealsa[3407]: ../src/ba-transport.c:381: Closing A2DP transport: 15 Oct 14 12:22:10 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:257: Exiting IO thread [ba-a2dp-sbc]: A2DP Sink (SBC) Oct 14 12:22:11 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/ba-transport.c:319: New A2DP transport: 15 Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/ba-transport.c:320: A2DP socket MTU: 15: R:672 W:1024 Oct 14 12:22:11 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/ba-transport.c:1075: Starting transport: A2DP Sink (SBC) Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:294: Created BT socket duplicate: [15]: 16 Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:373: Created new IO thread [ba-a2dp-sbc]: A2DP Sink (SBC) Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/a2dp-sbc.c:331: PCM IO loop: START: a2dp_sbc_dec_thread: A2DP Sink (SBC) Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay stderr: bluealsa-aplay: [7895] D: aplay.c:643: BT device marked as inactive: 79:33:E1:38:3C:7C Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [dbus-next] Playback state changed: true from 79:33:E1:38:3C:7C Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: setWinningMac: 79:33:E1:38:3C:7C Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Playback started, enabling output (party mode: last play wins) Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [AAMP] Modular pipeline enabled - forcing ALSA route: volumioLocalPlayback Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Party mode: using preferred BT MAC: 79:33:E1:38:3C:7C Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay already running for 79:33:E1:38:3C:7C. Skipping. Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [metaCache] Loaded metadata for 79:33:E1:38:3C:7C from memory Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Loaded metadata from cache for 79:33:E1:38:3C:7C Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:11 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:11 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:11 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:11 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:11 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:11 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:11.476Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=41 Oct 14 12:22:11 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:11.477Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:11 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:11.480Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=41 Oct 14 12:22:11 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:11.481Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:11 rivoplus bluealsa[3407]: ../src/codec-sbc.c:278: SBC setup: 44100 Hz JointStereo allocation=Loudness blocks=16 sub-bands=8 bit-pool=53 => 327993 bps Oct 14 12:22:11 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:11 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:11 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:11 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:11 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:11 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:11 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:11 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:11 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay stderr: bluealsa-aplay: [7895] D: aplay.c:732: Opening ALSA playback PCM: name=volumioLocalPlayback channels=2 rate=44100 Oct 14 12:22:11 rivoplus volumio[3643]: bluealsa-aplay: [7895] D: aplay.c:339: Opening ALSA mixer: name=default elem=Master index=0 Oct 14 12:22:11 rivoplus volumio[3643]: bluealsa-aplay: [7895] W: aplay.c:350: Couldn't open ALSA mixer: Mixer element not found Oct 14 12:22:11 rivoplus volumio[3643]: info: MCU Signalled Playback Active Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.086Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.111Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=24.50437ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.138Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=49.287779ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.144Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=55.990667ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.157Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=68.078708ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.164Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://securetoken.googleapis.com duration=78.257352ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.170Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://functions.volumio.cloud duration=80.778951ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.170Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://functions.volumio.cloud duration=83.12401ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.186Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://database.volumio.cloud duration=98.804764ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.208Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=http://pushupdates.volumio.org duration=121.342612ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.213Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://www.googleapis.com duration=126.224728ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.217Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=https://google.com duration=130.501642ms Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 12:22:13 rivoplus volumio[3643]: info: Discovery: Getting this device information Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 12:22:13 rivoplus volumio[3643]: verbose: New Socket.io Connection to 10.0.0.212:3000 from 10.0.0.219 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 12:22:13 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.474Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=http://plugins.volumio.org duration=386.919263ms Oct 14 12:22:13 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:13.641Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-307.840153ms timeout=10s endpoint=http://cddb.volumio.org duration=554.044899ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 14 12:22:14 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Fallback: pushing metadata after resume Oct 14 12:22:14 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:14 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:14 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:14 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:14 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:14 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:14 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:14 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:14.486Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=41 Oct 14 12:22:14 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:14.487Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:14 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:14 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:14 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:14 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:16 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:16 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:307: Closing BT socket duplicate [15]: 16 Oct 14 12:22:16 rivoplus bluealsa[3407]: ../src/ba-transport.c:381: Closing A2DP transport: 15 Oct 14 12:22:16 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:257: Exiting IO thread [ba-a2dp-sbc]: A2DP Sink (SBC) Oct 14 12:22:16 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay stderr: bluealsa-aplay: [7895] D: aplay.c:643: BT device marked as inactive: 79:33:E1:38:3C:7C Oct 14 12:22:17 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Debounce: emitting confirmed playback=false for 79:33:E1:38:3C:7C (transport.State=idle, after 800ms) Oct 14 12:22:17 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [dbus-next] Playback state changed: false from 79:33:E1:38:3C:7C Oct 14 12:22:17 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Received pause signal from winner, scheduling idle check Oct 14 12:22:17 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:17 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:17 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:17 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:17 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:17 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:17 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:17 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:17.271Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=41 Oct 14 12:22:17 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:17.273Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:17 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:17 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:17 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:17 rivoplus volumio[3643]: info: MCU Signalled Playback Inactive Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 14 12:22:19 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Oct 14 12:22:37 rivoplus volumio[3643]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:37 rivoplus volumio[3643]: info: Restoring Previous Volume level: 100 false false Oct 14 12:22:37 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:22:37 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:22:37 rivoplus sudo[8032]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:22:37 rivoplus sudo[8032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus sudo[8032]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:37 rivoplus sudo[8034]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:22:37 rivoplus sudo[8034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:22:37 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:37 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus vtcs[6943]: [2026-10-14 12:22:37.459] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 14 12:22:37 rivoplus vtcs[6943]: [2026-10-14 12:22:37.466] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 14 12:22:37 rivoplus volumio[3643]: info: Volume configurations have been set Oct 14 12:22:37 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:37 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Oct 14 12:22:37 rivoplus systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 14 12:22:37 rivoplus sudo[8043]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:22:37 rivoplus sudo[8043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 14 12:22:37 rivoplus volumio[3643]: info: Updating Volume Controller Parameters: Device: 5 Name: LAIV Harmony DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] self.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] transportManager.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] MAC resolved for push = 79:33:E1:38:3C:7C Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] Capabilities for 79:33:E1:38:3C:7C: {"Volume":true} Oct 14 12:22:37 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: pushVolumeToDevice: Device does not support D-Bus volume control (Volume method missing or inactive player) Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setVolume Oct 14 12:22:37 rivoplus volumio[3643]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setVolume] in plugin alsa_controller Oct 14 12:22:37 rivoplus sudo[8046]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:22:37 rivoplus sudo[8046]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 14 12:22:37 rivoplus volumio[3643]: info: Disabling external Volume Control Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:37 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:37 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:37 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:37.661Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:37 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:37.662Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:37 rivoplus systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 14 12:22:37 rivoplus systemd[1]: vtcs.service: Deactivated successfully. Oct 14 12:22:37 rivoplus systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 14 12:22:37 rivoplus sudo[8043]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:37 rivoplus sudo[8046]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:37 rivoplus sudo[8054]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:22:37 rivoplus sudo[8055]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:22:37 rivoplus sudo[8055]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus sudo[8054]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus sudo[8065]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:22:37 rivoplus sudo[8065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus sudo[8054]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:37 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:37 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:37 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:37 rivoplus sudo[8055]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:37 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:22:37 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:22:37 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:22:37 rivoplus volumio[3643]: info: VolumeController:: alsactl monitor closed, code: 0 Oct 14 12:22:37 rivoplus sudo[8070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:22:37 rivoplus sudo[8070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:37 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:37 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:22:38 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:22:38 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:22:38 rivoplus sudo[8070]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus sudo[8065]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:22:38 rivoplus sudo[8094]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:22:38 rivoplus sudo[8094]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:22:38 rivoplus sudo[8093]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:22:38 rivoplus sudo[8093]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 12:22:38 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:38 rivoplus sudo[8094]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus sudo[8093]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:22:38 rivoplus sudo[8111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:22:38 rivoplus sudo[8111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:22:38 rivoplus sudo[8115]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:22:38 rivoplus sudo[8115]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus sudo[8111]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:22:38 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:22:38 rivoplus qobuz-connect[8102]: Error: Application ID was not specified! Oct 14 12:22:38 rivoplus qobuz-connect[8102]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -m|--manufacturer: Manufacturer of the device Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -n|--deviceName: Device name Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -l|--model: Device's model name Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -s|--serialNumber: Device's serial number Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:22:38 rivoplus qobuz-connect[8102]: -h|--help: Print this help Oct 14 12:22:38 rivoplus sudo[8117]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:22:38 rivoplus sudo[8117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus sudo[8119]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:22:38 rivoplus sudo[8119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:22:38 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:22:38 rivoplus sudo[8115]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus sudo[8122]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:22:38 rivoplus sudo[8122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:38 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:22:38 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 12:22:38 rivoplus sudo[8119]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:22:38 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 12:22:38 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:22:38 rivoplus sudo[8089]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 14 12:22:38 rivoplus sudo[8089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 14 12:22:38 rivoplus sudo[8089]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:22:38 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:22:38 rivoplus sudo[8117]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:38 rivoplus volumio[3643]: info: Shairport-Sync Started Oct 14 12:22:39 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:22:39 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:22:39 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:22:39 rivoplus sudo[8122]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:39 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:22:39 rivoplus volumio[3643]: info: Executing endpoint restartRAATSocket Oct 14 12:22:39 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 14 12:22:40 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:22:40 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:22:40 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:22:40 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:22:41 rivoplus sudo[8178]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:22:41 rivoplus sudo[8178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:41 rivoplus sudo[8180]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:22:41 rivoplus sudo[8180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:22:41 rivoplus systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 14 12:22:41 rivoplus sudo[8178]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:41 rivoplus sudo[8180]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:41 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:22:41 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:22:41 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:22:41 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:22:41 rivoplus volumio[3643]: info: Executing endpoint tc_getconfig Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 14 12:22:41 rivoplus vtcs[8184]: STARTING TidalConnect services, version: 1.6.1 Oct 14 12:22:41 rivoplus vtcs[8184]: STARTED TidalConnect services. Oct 14 12:22:41 rivoplus volumio[3643]: info: Executing endpoint tc_connect Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 14 12:22:41 rivoplus volumio[3643]: info: Connecting to TidalConnect Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:41 rivoplus volumio[3643]: info: CorePlayQueue::getTrack 0 Oct 14 12:22:41 rivoplus volumio[3643]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 14 12:22:41 rivoplus volumio[3643]: verbose: CURRENT POSITION 0 Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::syncState stateService stop Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::syncState currentStatus pause Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:41 rivoplus volumio[3643]: info: CorePlayQueue::getTrack 0 Oct 14 12:22:41 rivoplus volumio[3643]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Oct 14 12:22:41 rivoplus volumio[3643]: verbose: CURRENT POSITION 0 Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::syncState stateService stop Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::syncState currentStatus pause Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.864Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.865Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.876Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.877Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.895Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.895Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.899Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.899Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:41 rivoplus volumio[3643]: info: VolumeController::SetAlsaVolume100 Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.954Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PAUSED positionMs=89374 volume=100 Oct 14 12:22:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:41.955Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:41 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:42 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:42 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:43 rivoplus mpd[8136]: 2026-10-14T12:22:43 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 14 12:22:43 rivoplus systemd[1]: Started mpd.service - Music Player Daemon. Oct 14 12:22:43 rivoplus sudo[8034]: pam_unix(sudo:session): session closed for user root Oct 14 12:22:43 rivoplus volumio[3643]: error: updateQueue error: null Oct 14 12:22:43 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 1. Oct 14 12:22:43 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:43 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:43 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:22:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:22:43 rivoplus qobuz-connect[8204]: Error: Application ID was not specified! Oct 14 12:22:43 rivoplus qobuz-connect[8204]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -m|--manufacturer: Manufacturer of the device Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -n|--deviceName: Device name Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -l|--model: Device's model name Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -s|--serialNumber: Device's serial number Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:22:43 rivoplus qobuz-connect[8204]: -h|--help: Print this help Oct 14 12:22:43 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:22:43 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:22:44 rivoplus volumio[3643]: info: TidalConnect service started! Oct 14 12:22:44 rivoplus volumio[3643]: info: TidalConnect service started! Oct 14 12:22:49 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 2. Oct 14 12:22:49 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:49 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:49 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:22:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:22:49 rivoplus qobuz-connect[8223]: Error: Application ID was not specified! Oct 14 12:22:49 rivoplus qobuz-connect[8223]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -m|--manufacturer: Manufacturer of the device Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -n|--deviceName: Device name Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -l|--model: Device's model name Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -s|--serialNumber: Device's serial number Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:22:49 rivoplus qobuz-connect[8223]: -h|--help: Print this help Oct 14 12:22:49 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:22:49 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:22:54 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 3. Oct 14 12:22:54 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:54 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:54 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:22:54 rivoplus qobuz-connect[8233]: Error: Application ID was not specified! Oct 14 12:22:54 rivoplus qobuz-connect[8233]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -m|--manufacturer: Manufacturer of the device Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -n|--deviceName: Device name Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -l|--model: Device's model name Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -s|--serialNumber: Device's serial number Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:22:54 rivoplus qobuz-connect[8233]: -h|--help: Print this help Oct 14 12:22:54 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:22:54 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:22:54 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/ba-transport.c:319: New A2DP transport: 15 Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/ba-transport.c:320: A2DP socket MTU: 15: R:672 W:1024 Oct 14 12:22:54 rivoplus bluealsa[3407]: bluez.c:1480: Signal: org.freedesktop.DBus.Properties.PropertiesChanged(): org.bluez.MediaTransport1: State Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/ba-transport.c:1075: Starting transport: A2DP Sink (SBC) Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:294: Created BT socket duplicate: [15]: 16 Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:373: Created new IO thread [ba-a2dp-sbc]: A2DP Sink (SBC) Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/a2dp-sbc.c:331: PCM IO loop: START: a2dp_sbc_dec_thread: A2DP Sink (SBC) Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [dbus-next] Playback state changed: true from 79:33:E1:38:3C:7C Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: setWinningMac: 79:33:E1:38:3C:7C Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Playback started, enabling output (party mode: last play wins) Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [AAMP] Modular pipeline enabled - forcing ALSA route: volumioLocalPlayback Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Party mode: using preferred BT MAC: 79:33:E1:38:3C:7C Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay already running for 79:33:E1:38:3C:7C. Skipping. Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [metaCache] Loaded metadata for 79:33:E1:38:3C:7C from memory Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Loaded metadata from cache for 79:33:E1:38:3C:7C Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:54 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:54 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:54 rivoplus bluealsa[3407]: ../src/codec-sbc.c:278: SBC setup: 44100 Hz JointStereo allocation=Loudness blocks=16 sub-bands=8 bit-pool=53 => 327993 bps Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:54 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:54 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:54 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:54 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:54.754Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=100 Oct 14 12:22:54 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:54.754Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:54 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:54.758Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=100 Oct 14 12:22:54 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:54.758Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:54 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:54 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:54 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:54 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:54 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:54 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:54 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:54 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:54 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay stderr: bluealsa-aplay: [7895] D: aplay.c:732: Opening ALSA playback PCM: name=volumioLocalPlayback channels=2 rate=44100 Oct 14 12:22:54 rivoplus volumio[3643]: bluealsa-aplay: [7895] D: aplay.c:339: Opening ALSA mixer: name=default elem=Master index=0 Oct 14 12:22:54 rivoplus volumio[3643]: bluealsa-aplay: [7895] W: aplay.c:350: Couldn't open ALSA mixer: Mixer element not found Oct 14 12:22:54 rivoplus volumio[3643]: info: MCU Signalled Playback Active Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.268Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.284Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=15.661753ms Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 12:22:57 rivoplus volumio[3643]: info: Discovery: Getting this device information Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.322Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=49.78669ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.323Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=52.839825ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.326Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=53.298862ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.342Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://functions.volumio.cloud duration=69.083323ms Oct 14 12:22:57 rivoplus volumio[3643]: verbose: New Socket.io Connection to 10.0.0.212:3000 from 10.0.0.219 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.348Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://securetoken.googleapis.com duration=78.776346ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.352Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://functions.volumio.cloud duration=78.578182ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.373Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://google.com duration=103.996417ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.385Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://www.googleapis.com duration=115.694587ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.393Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=http://pushupdates.volumio.org duration=120.165666ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.412Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=https://database.volumio.cloud duration=138.123103ms Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.664Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=http://plugins.volumio.org duration=390.439893ms Oct 14 12:22:57 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Fallback: pushing metadata after resume Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:22:57 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:22:57 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:22:57 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.765Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89374 volume=100 Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.765Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:22:57 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:22:57 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:57 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:22:57 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:22:57 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:22:57.944Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-305.45256ms timeout=10s endpoint=http://cddb.volumio.org duration=672.540291ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 14 12:22:59 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 4. Oct 14 12:22:59 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:59 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:22:59 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:22:59 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:22:59 rivoplus qobuz-connect[8272]: Error: Application ID was not specified! Oct 14 12:22:59 rivoplus qobuz-connect[8272]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -m|--manufacturer: Manufacturer of the device Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -n|--deviceName: Device name Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -l|--model: Device's model name Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -s|--serialNumber: Device's serial number Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:22:59 rivoplus qobuz-connect[8272]: -h|--help: Print this help Oct 14 12:22:59 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:22:59 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:03 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:03 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:03 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:03.094Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89413 volume=100 Oct 14 12:23:03 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:03.096Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:03 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:03 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:03 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:03 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::servicePushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:03 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:03 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:03 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:03 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:03.146Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=100 Oct 14 12:23:03 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:03.147Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:03 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:03 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:03 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:03 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:04 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 5. Oct 14 12:23:04 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:04 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:04 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:04 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:04 rivoplus qobuz-connect[8274]: Error: Application ID was not specified! Oct 14 12:23:04 rivoplus qobuz-connect[8274]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -n|--deviceName: Device name Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -l|--model: Device's model name Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -s|--serialNumber: Device's serial number Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:04 rivoplus qobuz-connect[8274]: -h|--help: Print this help Oct 14 12:23:04 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:04 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:10 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 6. Oct 14 12:23:10 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:10 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:10 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:10 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:10 rivoplus qobuz-connect[8301]: Error: Application ID was not specified! Oct 14 12:23:10 rivoplus qobuz-connect[8301]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -n|--deviceName: Device name Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -l|--model: Device's model name Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -s|--serialNumber: Device's serial number Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:10 rivoplus qobuz-connect[8301]: -h|--help: Print this help Oct 14 12:23:10 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:10 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:15 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 7. Oct 14 12:23:15 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:15 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:15 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:15 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:15 rivoplus qobuz-connect[8309]: Error: Application ID was not specified! Oct 14 12:23:15 rivoplus qobuz-connect[8309]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -n|--deviceName: Device name Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -l|--model: Device's model name Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -s|--serialNumber: Device's serial number Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:15 rivoplus qobuz-connect[8309]: -h|--help: Print this help Oct 14 12:23:15 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:15 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:20 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 8. Oct 14 12:23:20 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:20 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:20 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:20 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:20 rivoplus qobuz-connect[8335]: Error: Application ID was not specified! Oct 14 12:23:20 rivoplus qobuz-connect[8335]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -n|--deviceName: Device name Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -l|--model: Device's model name Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -s|--serialNumber: Device's serial number Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:20 rivoplus qobuz-connect[8335]: -h|--help: Print this help Oct 14 12:23:20 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:20 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.681Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.703Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=21.31082ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.729Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=42.315476ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.730Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=44.036625ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.736Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=49.737982ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.750Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://securetoken.googleapis.com duration=65.639983ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.751Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://database.volumio.cloud duration=65.109572ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.771Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://functions.volumio.cloud duration=85.386111ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.770Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://functions.volumio.cloud duration=84.796868ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.799Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://google.com duration=116.163208ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.800Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=http://pushupdates.volumio.org duration=115.074385ms Oct 14 12:23:21 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:21.804Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=https://www.googleapis.com duration=120.463746ms Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 12:23:21 rivoplus volumio[3643]: info: Discovery: Getting this device information Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 12:23:21 rivoplus volumio[3643]: verbose: New Socket.io Connection to 10.0.0.212:3000 from 10.0.0.219 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 12:23:21 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 12:23:22 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:22.048Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=http://plugins.volumio.org duration=362.13298ms Oct 14 12:23:22 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:22.451Z level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" latency=-306.266248ms timeout=10s endpoint=http://cddb.volumio.org duration=766.10165ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 14 12:23:25 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 9. Oct 14 12:23:25 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:25 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:25 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:25 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:25 rivoplus qobuz-connect[8345]: Error: Application ID was not specified! Oct 14 12:23:25 rivoplus qobuz-connect[8345]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -n|--deviceName: Device name Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -l|--model: Device's model name Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -s|--serialNumber: Device's serial number Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:25 rivoplus qobuz-connect[8345]: -h|--help: Print this help Oct 14 12:23:25 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:25 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:31 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 10. Oct 14 12:23:31 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:31 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:31 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:31 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:31 rivoplus qobuz-connect[8372]: Error: Application ID was not specified! Oct 14 12:23:31 rivoplus qobuz-connect[8372]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -n|--deviceName: Device name Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -l|--model: Device's model name Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -s|--serialNumber: Device's serial number Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:31 rivoplus qobuz-connect[8372]: -h|--help: Print this help Oct 14 12:23:31 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:31 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:36 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 11. Oct 14 12:23:36 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:36 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:36 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:36 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:36 rivoplus qobuz-connect[8398]: Error: Application ID was not specified! Oct 14 12:23:36 rivoplus qobuz-connect[8398]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -n|--deviceName: Device name Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -l|--model: Device's model name Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -s|--serialNumber: Device's serial number Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:36 rivoplus qobuz-connect[8398]: -h|--help: Print this help Oct 14 12:23:36 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:36 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:41 rivoplus volumio[3643]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus volumio[3643]: info: Restoring Previous Volume level: 100 false true Oct 14 12:23:41 rivoplus volumio[3643]: info: VolumeController::SetAlsaVolume100 Oct 14 12:23:41 rivoplus volumio[3643]: info: Enable softmixer device for audio device number 5 Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioStop Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreStateMachine::stop Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreStateMachine::serviceStop Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::serviceStop Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [FUNC] stop Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Killing bluealsa-aplay process Oct 14 12:23:41 rivoplus volumio[3643]: info: Enable softmixer device for audio device undefined Oct 14 12:23:41 rivoplus bluealsa[3407]: ../src/ba-transport-pcm.c:453: Closing PCM: 18 Oct 14 12:23:41 rivoplus bluealsa[3407]: ../src/ba-transport.c:203: PCM clients check keep-alive: 0 ms Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 14 12:23:41 rivoplus volumio[3643]: info: Updating Volume Controller Parameters: Device: 5 Name: LAIV Harmony DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 14 12:23:41 rivoplus volumio[3643]: info: Disabling external Volume Control Oct 14 12:23:41 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:41 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:41 rivoplus sudo[8411]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:41 rivoplus sudo[8411]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus sudo[8411]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus sudo[8412]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:41 rivoplus sudo[8412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus vtcs[8184]: [2026-10-14 12:23:41.316] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 14 12:23:41 rivoplus vtcs[8184]: [2026-10-14 12:23:41.312] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 14 12:23:41 rivoplus volumio[3643]: info: Volume configurations have been set Oct 14 12:23:41 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Oct 14 12:23:41 rivoplus systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 14 12:23:41 rivoplus sudo[8421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:41 rivoplus sudo[8421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus sudo[8423]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:41 rivoplus sudo[8423]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus systemd[1]: qobuz-connect.service: Scheduled restart job, restart counter is at 12. Oct 14 12:23:41 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 14 12:23:41 rivoplus volumio[3643]: info: Updating Volume Controller Parameters: Device: 5 Name: LAIV Harmony DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 14 12:23:41 rivoplus volumio[3643]: info: Disabling external Volume Control Oct 14 12:23:41 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:41 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:23:41 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:41 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:23:41 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:23:41 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.514Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=100 Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.515Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.520Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=100 Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.524Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:41 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:23:41 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:23:41 rivoplus systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 14 12:23:41 rivoplus systemd[1]: vtcs.service: Deactivated successfully. Oct 14 12:23:41 rivoplus systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 14 12:23:41 rivoplus sudo[8447]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:41 rivoplus sudo[8447]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus sudo[8450]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:41 rivoplus sudo[8421]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus sudo[8450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus sudo[8423]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus sudo[8458]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:41 rivoplus sudo[8458]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:41 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:41 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:41 rivoplus sudo[8447]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:41 rivoplus sudo[8464]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:41 rivoplus sudo[8464]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:41 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:41 rivoplus sudo[8458]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: bluealsa-aplay exited with code null, signal SIGKILL Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:41 rivoplus sudo[8450]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:41 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.835Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume= Oct 14 12:23:41 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:41.835Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:41 rivoplus sudo[8467]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:41 rivoplus sudo[8467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus sudo[8464]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:41 rivoplus sudo[8470]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:41 rivoplus sudo[8470]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:41 rivoplus systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 14 12:23:41 rivoplus systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 14 12:23:41 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:41 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:41 rivoplus sudo[8467]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:41 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:42 rivoplus systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 14 12:23:42 rivoplus systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 14 12:23:42 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:42 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:42 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:42 rivoplus volumio[3643]: info: Software Volume ALSA configuration written Oct 14 12:23:42 rivoplus volumio[3643]: info: Preparing to generate the ALSA configuration file Oct 14 12:23:42 rivoplus sudo[8470]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus volumio[3643]: info: VolumeController::SetAlsaVolume0 Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 0 - forwarding to Bluetooth device Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 0 - forwarding to Bluetooth device Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] self.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] transportManager.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] MAC resolved for push = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] Capabilities for 79:33:E1:38:3C:7C: {"Volume":true} Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: pushVolumeToDevice: Device does not support D-Bus volume control (Volume method missing or inactive player) Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setVolume Oct 14 12:23:42 rivoplus volumio[3643]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setVolume] in plugin alsa_controller Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:42 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:42 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:42 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:42.121Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=0 Oct 14 12:23:42 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:42.122Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:42 rivoplus volumio[3643]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 14 12:23:42 rivoplus volumio[3643]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 14 12:23:42 rivoplus volumio[3643]: info: Reading ALSA contributions from plugins. Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus sudo[8445]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 14 12:23:42 rivoplus sudo[8445]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:42 rivoplus sudo[8445]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Oct 14 12:23:42 rivoplus volumio[3643]: info: VolumeController::SetAlsaVolume0 Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 0 - forwarding to Bluetooth device Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 0 - forwarding to Bluetooth device Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] self.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] transportManager.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] MAC resolved for push = 79:33:E1:38:3C:7C Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] Capabilities for 79:33:E1:38:3C:7C: {"Volume":true} Oct 14 12:23:42 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: pushVolumeToDevice: Device does not support D-Bus volume control (Volume method missing or inactive player) Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setVolume Oct 14 12:23:42 rivoplus volumio[3643]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setVolume] in plugin alsa_controller Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:42 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:42 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:42 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:42.349Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=0 Oct 14 12:23:42 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:42.349Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:42 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:42 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:42 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:42 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:42 rivoplus sudo[8500]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:42 rivoplus sudo[8500]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:42 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:42 rivoplus sudo[8500]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus qobuz-connect[8481]: Error: Application ID was not specified! Oct 14 12:23:42 rivoplus qobuz-connect[8481]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -n|--deviceName: Device name Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -l|--model: Device's model name Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -s|--serialNumber: Device's serial number Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:42 rivoplus qobuz-connect[8481]: -h|--help: Print this help Oct 14 12:23:42 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:42 rivoplus volumio[3643]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Oct 14 12:23:42 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:23:42 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:42 rivoplus sudo[8506]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:42 rivoplus sudo[8506]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus sudo[8505]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:42 rivoplus sudo[8505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus volumio[3643]: info: Asound.conf file written Oct 14 12:23:42 rivoplus sudo[8510]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:23:42 rivoplus sudo[8510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus sudo[8505]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:23:42 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:23:42 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:23:42 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:23:42 rivoplus sudo[8506]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus sudo[8513]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:42 rivoplus sudo[8513]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus sudo[8514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 14 12:23:42 rivoplus sudo[8514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 12:23:42 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 12:23:42 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:42 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:23:42 rivoplus sudo[8514]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:42 rivoplus sudo[8510]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:23:42 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:23:42 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:23:42 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:42 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:42 rivoplus volumio[3643]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 14 12:23:42 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:42 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Oct 14 12:23:42 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:42 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:88ea" "" "" Oct 14 12:23:42 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:42 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:42 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:42 rivoplus sudo[8513]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:42 rivoplus sudo[8527]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:42 rivoplus sudo[8527]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:42 rivoplus sudo[8527]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:43 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:43 rivoplus sudo[8548]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:43 rivoplus sudo[8548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:43 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:23:43 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:23:43 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:23:43 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:23:43 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:23:43 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:43 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:23:43 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:23:43 rivoplus sudo[8558]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:43 rivoplus sudo[8558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus volumio[3643]: ALSA lib ./src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Oct 14 12:23:43 rivoplus volumio[3643]: aplay: main:831: audio open error: Device or resource busy Oct 14 12:23:43 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:43 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:43 rivoplus volumio[3643]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 14 12:23:43 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:43 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Oct 14 12:23:43 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:43 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:88ea" "" "" Oct 14 12:23:43 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:43 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:43 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:43 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Oct 14 12:23:43 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:43 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:43 rivoplus sudo[8568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:43 rivoplus sudo[8566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:43 rivoplus sudo[8566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus sudo[8568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus sudo[8570]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:43 rivoplus sudo[8570]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus sudo[8568]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:43 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:43 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:43 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:43 rivoplus sudo[8580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:43 rivoplus sudo[8580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 14 12:23:43 rivoplus volumio[3643]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] self.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] transportManager.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] MAC resolved for push = 79:33:E1:38:3C:7C Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] Capabilities for 79:33:E1:38:3C:7C: {"Volume":true} Oct 14 12:23:43 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: pushVolumeToDevice: Device does not support D-Bus volume control (Volume method missing or inactive player) Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setVolume Oct 14 12:23:43 rivoplus volumio[3643]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setVolume] in plugin alsa_controller Oct 14 12:23:43 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 14 12:23:43 rivoplus volumio[3643]: info: Disabling external Volume Control Oct 14 12:23:43 rivoplus sudo[8558]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:43 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:23:43 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:23:43 rivoplus sudo[8566]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus sudo[8592]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:44 rivoplus sudo[8592]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus sudo[8594]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:44 rivoplus sudo[8594]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus sudo[8597]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:44 rivoplus sudo[8597]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:23:44 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:23:44 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:23:44 rivoplus sudo[8606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:23:44 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:23:44 rivoplus sudo[8613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:44 rivoplus sudo[8619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:44 rivoplus sudo[8580]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:44 rivoplus sudo[8606]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus sudo[8613]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:44 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:44 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:44 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:44.542Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=100 Oct 14 12:23:44 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:44.543Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:44 rivoplus sudo[8638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus volumio[3643]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Oct 14 12:23:44 rivoplus volumio[3643]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 14 12:23:44 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:44 rivoplus volumio[3643]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 14 12:23:44 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:44 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:23:44 rivoplus volumio[3643]: info: Shairport-Sync Started Oct 14 12:23:44 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:23:44 rivoplus sudo[8619]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus sudo[8636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus volumio[3643]: info: Executing endpoint restartRAATSocket Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus sudo[8643]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:44 rivoplus sudo[8643]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:44 rivoplus sudo[8592]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus sudo[8594]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus sudo[8597]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:44 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:44 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:44 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:45 rivoplus sudo[8638]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus sudo[8643]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus sudo[8636]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:45 rivoplus sudo[8614]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 14 12:23:45 rivoplus sudo[8614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 14 12:23:45 rivoplus sudo[8667]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:45 rivoplus sudo[8667]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus sudo[8614]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:45 rivoplus sudo[8667]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus sudo[8672]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:45 rivoplus sudo[8672]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus sudo[8674]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:45 rivoplus sudo[8674]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:45 rivoplus sudo[8674]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:45 rivoplus sudo[8680]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:45 rivoplus sudo[8680]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:23:45 rivoplus sudo[8682]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:45 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:23:45 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:23:45 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:45 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Oct 14 12:23:45 rivoplus sudo[8682]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus sudo[8672]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:23:45 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:45 rivoplus qobuz-connect[8662]: Error: Application ID was not specified! Oct 14 12:23:45 rivoplus qobuz-connect[8662]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -n|--deviceName: Device name Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -l|--model: Device's model name Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -s|--serialNumber: Device's serial number Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:45 rivoplus qobuz-connect[8662]: -h|--help: Print this help Oct 14 12:23:45 rivoplus sudo[8693]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:45 rivoplus sudo[8693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:23:45 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:23:45 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:23:45 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:23:45 rivoplus sudo[8702]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:23:45 rivoplus sudo[8703]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:23:45 rivoplus sudo[8703]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus sudo[8702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:23:45 rivoplus volumio[3643]: info: Preparing to generate the ALSA configuration file Oct 14 12:23:45 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:45 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:45 rivoplus volumio[3643]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 14 12:23:45 rivoplus volumio[3643]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 14 12:23:45 rivoplus volumio[3643]: info: Reading ALSA contributions from plugins. Oct 14 12:23:45 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:23:45 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:23:45 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:45 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:45 rivoplus sudo[8680]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:45 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:45 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:45 rivoplus volumio[3643]: info: VolumeController::SetAlsaVolume100 Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [VOLUME HOOK] Intercepted volume 100 - forwarding to Bluetooth device Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] self.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] transportManager.currentMAC = 79:33:E1:38:3C:7C Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] MAC resolved for push = 79:33:E1:38:3C:7C Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: [DEBUG] Capabilities for 79:33:E1:38:3C:7C: {"Volume":true} Oct 14 12:23:45 rivoplus volumio[3643]: ------------------------------------ BT MESSAGE: pushVolumeToDevice: Device does not support D-Bus volume control (Volume method missing or inactive player) Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setVolume Oct 14 12:23:45 rivoplus volumio[3643]: info: Error : CoreCommandRouter::executeOnPlugin: No method [setVolume] in plugin alsa_controller Oct 14 12:23:45 rivoplus sudo[8715]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:45 rivoplus sudo[8715]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreStateMachine::pushState Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::volumioPushState Oct 14 12:23:45 rivoplus sudo[8717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:23:45 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:45 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output update for this device Oct 14 12:23:45 rivoplus volumio[3643]: info: MRS: Pushing multiroomSync output Oct 14 12:23:45 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:45.831Z level=INFO msg="emitting player state changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" state=STATUS_PLAYING positionMs=89447 volume=100 Oct 14 12:23:45 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:45.831Z level=INFO msg="emitting player metadata changed event" component=server peer="10.0.0.219:43868,00:00:00:00:00:00%05 @ 0x34cede0" id= title="Make Me Feel" Oct 14 12:23:45 rivoplus sudo[8717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus sudo[8718]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:23:45 rivoplus sudo[8718]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:45 rivoplus volumio[3643]: info: Signalling Playback active due to playback status change Oct 14 12:23:45 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:45 rivoplus volumio[3643]: info: Updating RAAT Signal Path Oct 14 12:23:45 rivoplus volumio[3643]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 14 12:23:45 rivoplus volumio[3643]: info: Asound.conf file written Oct 14 12:23:46 rivoplus sudo[8724]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 14 12:23:46 rivoplus sudo[8724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus sudo[8724]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:23:46 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 12:23:46 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:46 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:46 rivoplus volumio[3643]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 14 12:23:46 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:46 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Oct 14 12:23:46 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:46 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:88ea" "" "" Oct 14 12:23:46 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:46 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:46 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:46 rivoplus systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 14 12:23:46 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:46 rivoplus sudo[8734]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:46 rivoplus sudo[8739]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:46 rivoplus sudo[8739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus sudo[8734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 12:23:46 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:46 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:23:46 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:23:46 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:46 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus sudo[8734]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:46 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: Preparing to generate the ALSA configuration file Oct 14 12:23:46 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:23:46 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:23:46 rivoplus sudo[8717]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus sudo[8718]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus sudo[8760]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:46 rivoplus sudo[8760]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:23:46 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:23:46 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 14 12:23:46 rivoplus volumio[3643]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 14 12:23:46 rivoplus volumio[3643]: info: Reading ALSA contributions from plugins. Oct 14 12:23:46 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:46 rivoplus sudo[8715]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:23:46 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:23:46 rivoplus sudo[8765]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:46 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:23:46 rivoplus sudo[8765]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus sudo[8682]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:46 rivoplus sudo[8777]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:46 rivoplus sudo[8777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: Raat Daemon started successfully Oct 14 12:23:46 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:46 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:23:46 rivoplus sudo[8703]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus sudo[8702]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:46 rivoplus volumio[3643]: info: Shairport-Sync Started Oct 14 12:23:46 rivoplus volumio[3643]: (node:3643) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 14 12:23:46 rivoplus volumio[3643]: (node:3643) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 14 12:23:46 rivoplus volumio[3643]: (node:3643) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 14 12:23:46 rivoplus volumio[3643]: (node:3643) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 14 12:23:46 rivoplus volumio[3643]: (node:3643) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Oct 14 12:23:46 rivoplus volumio[3643]: info: Shairport-Sync Started Oct 14 12:23:46 rivoplus sudo[8788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:23:46 rivoplus sudo[8788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:46 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:46 rivoplus volumio[3643]: info: Asound.conf file unchanged, so no further update is needed Oct 14 12:23:46 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:47 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:47 rivoplus sudo[8795]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:47 rivoplus sudo[8795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus sudo[8798]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:47 rivoplus sudo[8798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus sudo[8795]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:47 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus sudo[8777]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:47 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: Preparing to generate the ALSA configuration file Oct 14 12:23:47 rivoplus sudo[8817]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:47 rivoplus sudo[8817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 12:23:47 rivoplus systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 14 12:23:47 rivoplus sudo[8821]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:47 rivoplus sudo[8821]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus systemd[1]: vtcs.service: Deactivated successfully. Oct 14 12:23:47 rivoplus systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 14 12:23:47 rivoplus sudo[8825]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:47 rivoplus sudo[8825]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 12:23:47 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:47 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:47 rivoplus volumio[3643]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 14 12:23:47 rivoplus volumio[3643]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 14 12:23:47 rivoplus volumio[3643]: info: Reading ALSA contributions from plugins. Oct 14 12:23:47 rivoplus volumio[3643]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Oct 14 12:23:47 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:47 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:47 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:47 rivoplus sudo[8831]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:47 rivoplus sudo[8831]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus sudo[8765]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus sudo[8836]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:47 rivoplus sudo[8836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus sudo[8760]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:47 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:47 rivoplus volumio[3643]: info: Starting Shairport Sync Oct 14 12:23:47 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 14 12:23:47 rivoplus sudo[8831]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus sudo[8836]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:47 rivoplus sudo[8851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 12:23:47 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:47 rivoplus sudo[8851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:47 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:48 rivoplus sudo[8854]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:48 rivoplus sudo[8854]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:48 rivoplus sudo[8855]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:48 rivoplus sudo[8855]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:48 rivoplus volumio[3643]: info: TidalConnect service stoped! Oct 14 12:23:48 rivoplus sudo[8817]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus sudo[8858]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 14 12:23:48 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:23:48 rivoplus sudo[8858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:48 rivoplus sudo[8788]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:23:48 rivoplus volumio[3643]: info: Shairport-Sync Started Oct 14 12:23:48 rivoplus volumio[3643]: info: Asound.conf file written Oct 14 12:23:48 rivoplus sudo[8881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 14 12:23:48 rivoplus sudo[8881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus systemd[1]: mpd.service: Deactivated successfully. Oct 14 12:23:48 rivoplus systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 14 12:23:48 rivoplus sudo[8881]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:48 rivoplus volumio[3643]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Oct 14 12:23:48 rivoplus volumio[3643]: Found hardware: "AML-AUGESOUND-M" "" "" "" "" Oct 14 12:23:48 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card AMLAUGESOUNDMP1 Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:48 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB2fc6:6016" "" "" Oct 14 12:23:48 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card Device Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:48 rivoplus volumio[3643]: Found hardware: "USB-Audio" "USB Mixer" "USB152a:88ea" "" "" Oct 14 12:23:48 rivoplus volumio[3643]: Hardware is initialized using a generic method Oct 14 12:23:48 rivoplus volumio[3643]: No state is present for card DAC Oct 14 12:23:48 rivoplus volumio[3643]: info: Output device has changed, restarting MPD Oct 14 12:23:48 rivoplus volumio[3643]: info: Output device has changed, restarting Shairport Sync Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:48 rivoplus volumio[3643]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 12:23:48 rivoplus volumio[3643]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:48 rivoplus sudo[8909]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 12:23:48 rivoplus sudo[8909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus sudo[8904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 12:23:48 rivoplus sudo[8904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus volumio[3643]: info: QobuzConnect: setDeactiveState invoked Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::volumioGetState Oct 14 12:23:48 rivoplus volumio[3643]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:48 rivoplus sudo[8825]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus sudo[8904]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus volumio[3643]: info: Preparing to generate the ALSA configuration file Oct 14 12:23:48 rivoplus sudo[8916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:48 rivoplus sudo[8916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus sudo[8821]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:48 rivoplus sudo[8921]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 14 12:23:48 rivoplus sudo[8921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:23:48 rivoplus volumio[3643]: info: RAAT: Requesting Headphone Status Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Oct 14 12:23:48 rivoplus volumio[3643]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 14 12:23:48 rivoplus volumio[3643]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 14 12:23:48 rivoplus volumio[3643]: info: Reading ALSA contributions from plugins. Oct 14 12:23:48 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:23:48 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:23:48 rivoplus sudo[8926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 14 12:23:48 rivoplus volumio[3643]: info: MPD Permissions set Oct 14 12:23:48 rivoplus sudo[8926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:48 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:48 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:49 rivoplus sudo[8858]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus volumio[3643]: info: Executing endpoint qc_getconfig Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 14 12:23:49 rivoplus qobuz-connect[8861]: Error: Application ID was not specified! Oct 14 12:23:49 rivoplus qobuz-connect[8861]: Usage: /usr/local/bin/qobuz-connect-daemon [OPTIONS...] Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -m|--manufacturer: Manufacturer of the device Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -n|--deviceName: Device name Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -l|--model: Device's model name Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -s|--serialNumber: Device's serial number Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -o|--outputDevice: ALSA PCM device to play audio to Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -p|--port: Port to run the local configuration HTTP server on Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -q|--maxAudioQuality: Force maximum supported audio quality [CD, HIRES1, HIRES2, HIRES3] Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -v|--volumeDevice: ALSA mixer device to use to for volume & mute control Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -u|--volumeElement: Name of the element found on the volume device to use to for volume & mute control Oct 14 12:23:49 rivoplus qobuz-connect[8861]: -h|--help: Print this help Oct 14 12:23:49 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:49 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:49 rivoplus sudo[8934]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 14 12:23:49 rivoplus sudo[8934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:49 rivoplus sudo[8935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:23:49 rivoplus sudo[8935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:49 rivoplus systemd[1]: qobuz-connect.service: Main process exited, code=exited, status=1/FAILURE Oct 14 12:23:49 rivoplus systemd[1]: qobuz-connect.service: Failed with result 'exit-code'. Oct 14 12:23:49 rivoplus volumio[3643]: info: Executing endpoint restartRAATSocket Oct 14 12:23:49 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Oct 14 12:23:49 rivoplus volumio[3643]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:49 rivoplus volumio[3643]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 14 12:23:49 rivoplus sudo[8942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:23:49 rivoplus sudo[8942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:49 rivoplus sudo[8945]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 14 12:23:49 rivoplus sudo[8945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:49 rivoplus sudo[8926]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: Not Reporting Auto name since its the default one Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus sudo[8952]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 14 12:23:49 rivoplus sudo[8952]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 12:23:49 rivoplus sudo[8916]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus sudo[8921]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 12:23:49 rivoplus volumio[3643]: info: MCU Signalled Headphone Mode Disabled Oct 14 12:23:49 rivoplus volumio[3643]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 14 12:23:49 rivoplus systemd[1]: Stopping raat-daemon.service - RAAT DAEMON... Oct 14 12:23:49 rivoplus systemd[1]: mpd.socket: Deactivated successfully. Oct 14 12:23:49 rivoplus volumio[3643]: info: TidalConnect service started! Oct 14 12:23:49 rivoplus systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 14 12:23:49 rivoplus systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 14 12:23:49 rivoplus volumio[3643]: error: Error starting TidalConnect Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Oct 14 12:23:49 rivoplus volumio[3643]: Job for vtcs.service canceled. Oct 14 12:23:49 rivoplus volumio[3643]: {"cmd":"/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3","code":1,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3\nJob for vtcs.service canceled.\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)","stderr":"Job for vtcs.service canceled.\n","stdout":""} Oct 14 12:23:49 rivoplus volumio[3643]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 12:23:49 rivoplus volumio[3643]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3 Oct 14 12:23:49 rivoplus volumio[3643]: Job for vtcs.service canceled. Oct 14 12:23:49 rivoplus volumio[3643]: at ChildProcess.exithandler (node:child_process:421:12) Oct 14 12:23:49 rivoplus volumio[3643]: at ChildProcess.emit (node:events:514:28) Oct 14 12:23:49 rivoplus volumio[3643]: at maybeClose (node:internal/child_process:1105:16) Oct 14 12:23:49 rivoplus volumio[3643]: at Socket. (node:internal/child_process:457:11) Oct 14 12:23:49 rivoplus volumio[3643]: at Socket.emit (node:events:514:28) Oct 14 12:23:49 rivoplus volumio[3643]: at Pipe. (node:net:337:12) { Oct 14 12:23:49 rivoplus volumio[3643]: code: 1, Oct 14 12:23:49 rivoplus volumio[3643]: killed: false, Oct 14 12:23:49 rivoplus volumio[3643]: signal: null, Oct 14 12:23:49 rivoplus volumio[3643]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3', Oct 14 12:23:49 rivoplus volumio[3643]: stdout: '', Oct 14 12:23:49 rivoplus volumio[3643]: stderr: 'Job for vtcs.service canceled.\n' Oct 14 12:23:49 rivoplus volumio[3643]: } Oct 14 12:23:49 rivoplus volumio[3643]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 12:23:49 rivoplus systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 12:23:49 rivoplus systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 12:23:49 rivoplus systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:49 rivoplus systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 14 12:23:49 rivoplus sudo[8854]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 12:23:49 rivoplus systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Oct 14 12:23:49 rivoplus sudo[8945]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus sudo[8935]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus sudo[8942]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:49 rivoplus systemd[1]: raat-daemon.service: Deactivated successfully. Oct 14 12:23:49 rivoplus systemd[1]: Stopped raat-daemon.service - RAAT DAEMON. Oct 14 12:23:49 rivoplus systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 12:23:49 rivoplus systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:50 rivoplus sudo[8952]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:50 rivoplus systemd[1]: Started raat-daemon.service - RAAT DAEMON. Oct 14 12:23:50 rivoplus sudo[8855]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:50 rivoplus sudo[8934]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:50 rivoplus systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 12:23:50 rivoplus sudo[8851]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:50 rivoplus volumio5-onboarding[4231]: time=2026-10-14T16:23:50.354Z level=WARN msg="pending write exceeded maximum retries, dropping" component=ble/conn addr=5 chunks=2 index=1 tries=11 Oct 14 12:23:50 rivoplus sudo[8963]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 14 12:23:50 rivoplus sudo[8963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 14 12:23:50 rivoplus sudo[8963]: pam_unix(sudo:session): session closed for user root Oct 14 12:23:51 rivoplus sudo[8999]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 12:22' Oct 14 12:23:51 rivoplus sudo[8999]: 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"