-- Logs begin at Sat 2025-12-20 16:20:54 SAST, end at Sat 2025-12-20 18:59:29 SAST. -- Dec 20 18:58:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:00.241Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=122 Dec 20 18:58:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:00.518Z level=INFO msg="new address was allocated" component=conn/ble old=139 new=140 Dec 20 18:58:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:00.542Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=9 Dec 20 18:58:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:00.843Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=54 Dec 20 18:58:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:01.144Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=165 Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 18:58:01 rivo-plus volumio[3213]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 20 18:58:01 rivo-plus volumio[3213]: info: Received Get System Version Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 18:58:01 rivo-plus volumio[3213]: info: Received Get System Info Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:58:01 rivo-plus volumio[3213]: info: Discovery: Getting this device information Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:01 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:01 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:58:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:01.445Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=133 Dec 20 18:58:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:01.746Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=160 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.046Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=1 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.046Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=1 chunks=1 index=0 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.272Z level=INFO msg="new address was allocated" component=conn/ble old=140 new=141 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.347Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=135 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.648Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=154 Dec 20 18:58:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:02.949Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=21 Dec 20 18:58:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:03.250Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=110 Dec 20 18:58:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:03.553Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=80 Dec 20 18:58:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:03.825Z level=INFO msg="new address was allocated" component=conn/ble old=141 new=142 Dec 20 18:58:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:03.853Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=101 Dec 20 18:58:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:04.154Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=28 Dec 20 18:58:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:04.154Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=139 chunks=1 index=0 Dec 20 18:58:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:04.455Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=93 Dec 20 18:58:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:04.756Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=70 Dec 20 18:58:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:05.056Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=18 Dec 20 18:58:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:05.243Z level=INFO msg="new address was allocated" component=conn/ble old=142 new=143 Dec 20 18:58:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:05.358Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=29 Dec 20 18:58:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:05.658Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=107 Dec 20 18:58:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:05.959Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=55 Dec 20 18:58:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:06.259Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=163 Dec 20 18:58:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:06.561Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=65 Dec 20 18:58:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:06.729Z level=INFO msg="new address was allocated" component=conn/ble old=143 new=144 Dec 20 18:58:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:06.862Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=222 Dec 20 18:58:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:07.163Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=189 Dec 20 18:58:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:07.464Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=85 Dec 20 18:58:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:07.765Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=116 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.010Z level=INFO msg="new address was allocated" component=conn/ble old=144 new=145 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.066Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=120 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.367Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=156 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.667Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=185 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.667Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=165 chunks=1 index=0 Dec 20 18:58:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:08.967Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=29 Dec 20 18:58:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:09.269Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=232 Dec 20 18:58:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:09.496Z level=INFO msg="new address was allocated" component=conn/ble old=145 new=146 Dec 20 18:58:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:09.570Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=60 Dec 20 18:58:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:09.871Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=77 Dec 20 18:58:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:09.871Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=224 chunks=1 index=0 Dec 20 18:58:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:10.172Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=60 Dec 20 18:58:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:10.472Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=23 Dec 20 18:58:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:10.773Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=52 Dec 20 18:58:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:11.073Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=156 Dec 20 18:58:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:11.251Z level=INFO msg="new address was allocated" component=conn/ble old=146 new=147 Dec 20 18:58:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:11.374Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=110 Dec 20 18:58:11 rivo-plus volumio[3213]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object] Dec 20 18:58:11 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI Dec 20 18:58:11 rivo-plus volumio[3213]: info: Setting active UI to: {"uiPrettyName":"Manifest","uiName":"manifest","uiPath":"/volumio/http/www4"} Dec 20 18:58:11 rivo-plus sudo[31884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/active_volumio_ui Dec 20 18:58:11 rivo-plus sudo[31884]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:11 rivo-plus sudo[31884]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:11.676Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=179 Dec 20 18:58:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:11.976Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:12.277Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=235 Dec 20 18:58:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:12.579Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=251 Dec 20 18:58:12 rivo-plus volumio[3213]: info: CoreCommandRouter::Reload Ui Dec 20 18:58:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:12.871Z level=INFO msg="new address was allocated" component=conn/ble old=147 new=148 Dec 20 18:58:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:12.879Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:58:13 rivo-plus sudo[31888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 18:58:13 rivo-plus sudo[31888]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:13 rivo-plus sudo[31888]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:13.180Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:13 rivo-plus sudo[31892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 18:58:13 rivo-plus sudo[31892]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:13 rivo-plus sudo[31892]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:13 rivo-plus volumio[3213]: verbose: New Socket.io Connection to 192.168.68.132 from 192.168.68.112 UA: Mozilla/5.0 (Linux; Android 13; LM-V600 Build/TKQ1.220829.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 18:58:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:13.482Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=27 Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:13 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 18:58:13 rivo-plus volumio[3213]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 20 18:58:13 rivo-plus volumio[3213]: info: Received Get System Info Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:58:13 rivo-plus volumio[3213]: info: Discovery: Getting this device information Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:13 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:13 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:13 rivo-plus volumio[3213]: info: Listing playlists Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Dec 20 18:58:13 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 20 18:58:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:13.783Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=178 Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.084Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=106 Dec 20 18:58:14 rivo-plus volumio[3213]: info: Received Get System Version Dec 20 18:58:14 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.384Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.685Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=123 Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.685Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=71 chunks=1 index=0 Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.692Z level=INFO msg="new address was allocated" component=conn/ble old=148 new=149 Dec 20 18:58:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:14.985Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=244 Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 18:58:15 rivo-plus volumio[3213]: info: Received Get System Info Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:58:15 rivo-plus volumio[3213]: info: Discovery: Getting this device information Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:15 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:58:15 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 20 18:58:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:15.287Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=175 Dec 20 18:58:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:15.587Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=19 Dec 20 18:58:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:15.888Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=148 Dec 20 18:58:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:15.907Z level=INFO msg="new address was allocated" component=conn/ble old=149 new=150 Dec 20 18:58:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:16.189Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=189 Dec 20 18:58:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:16.489Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=1 Dec 20 18:58:16 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 18:58:16 rivo-plus volumio[3213]: info: Received Get System Info Dec 20 18:58:16 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:58:16 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:58:16 rivo-plus volumio[3213]: info: Discovery: Getting this device information Dec 20 18:58:16 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:16 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:16 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:58:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:16.791Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=18 Dec 20 18:58:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:17.091Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=39 Dec 20 18:58:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:17.391Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=60 Dec 20 18:58:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:17.692Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:58:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:17.992Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:18.000Z level=INFO msg="new address was allocated" component=conn/ble old=150 new=151 Dec 20 18:58:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:18.293Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=93 Dec 20 18:58:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:18.593Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=149 Dec 20 18:58:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:18.593Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=55 chunks=1 index=0 Dec 20 18:58:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:18.894Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=111 Dec 20 18:58:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:19.194Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=173 Dec 20 18:58:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:19.350Z level=INFO msg="new address was allocated" component=conn/ble old=151 new=152 Dec 20 18:58:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:19.494Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:19.796Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=255 Dec 20 18:58:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:20.096Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=193 Dec 20 18:58:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:20.397Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=172 Dec 20 18:58:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:20.698Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=93 Dec 20 18:58:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:20.999Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=60 Dec 20 18:58:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:21.300Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=225 Dec 20 18:58:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:21.375Z level=INFO msg="new address was allocated" component=conn/ble old=152 new=153 Dec 20 18:58:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:21.601Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:21.902Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=166 Dec 20 18:58:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:22.202Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:58:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:22.503Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=94 Dec 20 18:58:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:22.804Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=163 Dec 20 18:58:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:22.928Z level=INFO msg="new address was allocated" component=conn/ble old=153 new=154 Dec 20 18:58:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:23.104Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:23 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 20 18:58:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:23.406Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=1 Dec 20 18:58:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:23.706Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=66 Dec 20 18:58:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:24.007Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=106 Dec 20 18:58:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:24.308Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=130 Dec 20 18:58:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:24.610Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=92 Dec 20 18:58:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:24.911Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=111 Dec 20 18:58:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:24.911Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=69 chunks=1 index=0 Dec 20 18:58:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:25.212Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=52 Dec 20 18:58:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:25.359Z level=INFO msg="new address was allocated" component=conn/ble old=154 new=155 Dec 20 18:58:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:25.513Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=181 Dec 20 18:58:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:25.814Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=102 Dec 20 18:58:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:26.114Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:58:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:26.415Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=42 Dec 20 18:58:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:26.716Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=99 Dec 20 18:58:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:26.776Z level=INFO msg="new address was allocated" component=conn/ble old=155 new=156 Dec 20 18:58:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:27.017Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=163 Dec 20 18:58:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:27.317Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=228 Dec 20 18:58:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:27.618Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=130 Dec 20 18:58:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:27.919Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=112 Dec 20 18:58:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:28.219Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:28.520Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=20 Dec 20 18:58:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:28.800Z level=INFO msg="new address was allocated" component=conn/ble old=156 new=157 Dec 20 18:58:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:28.821Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=47 Dec 20 18:58:28 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: Starting cast device: Q990D-820a56b2a7a49ee5e42b07ca242ba083 Dec 20 18:58:28 rivo-plus volumio[3213]: info: Enabled audio output: Q990D-820a56b2a7a49ee5e42b07ca242ba083 Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: Setting this device as Streaming Server Dec 20 18:58:28 rivo-plus volumio[3213]: info: Dec 20 18:58:28 rivo-plus volumio[3213]: [1766249908902] ---------------------------- MRS: Setting Streaming Server Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: enable multiroom server output Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioMultiRoom Dec 20 18:58:28 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Dec 20 18:58:28 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Dec 20 18:58:28 rivo-plus volumio[3213]: info: MRS: STARTING volumioStreaming Dec 20 18:58:29 rivo-plus sudo[31982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 18:58:29 rivo-plus sudo[31982]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:29 rivo-plus sudo[31982]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:29 rivo-plus sudo[31985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Dec 20 18:58:29 rivo-plus sudo[31985]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:29 rivo-plus systemd[1]: Started VolumioStreamingService. Dec 20 18:58:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:29.122Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=193 Dec 20 18:58:29 rivo-plus sudo[31985]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:29 rivo-plus volumio[3213]: info: MRS: volumioStreaming STARTED Dec 20 18:58:29 rivo-plus sudo[31989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 18:58:29 rivo-plus sudo[31989]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:29 rivo-plus sudo[31989]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:29.423Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:29.723Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=72 Dec 20 18:58:30 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:30.024Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=48 Dec 20 18:58:30 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:30.325Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=149 Dec 20 18:58:30 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:30.489Z level=INFO msg="new address was allocated" component=conn/ble old=157 new=158 Dec 20 18:58:30 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:30.626Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=165 Dec 20 18:58:30 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:30.927Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=128 Dec 20 18:58:31 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:31.228Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=232 Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 18:58:31 rivo-plus volumio[3213]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 20 18:58:31 rivo-plus volumio[3213]: info: Received Get System Version Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 18:58:31 rivo-plus volumio[3213]: info: Received Get System Info Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:58:31 rivo-plus volumio[3213]: info: Discovery: Getting this device information Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:31 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:31 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:58:31 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:31.529Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=215 Dec 20 18:58:31 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:31.529Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=70 chunks=1 index=0 Dec 20 18:58:31 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:31.529Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=149 chunks=1 index=0 Dec 20 18:58:31 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:31.830Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=160 Dec 20 18:58:32 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:32.040Z level=INFO msg="new address was allocated" component=conn/ble old=158 new=159 Dec 20 18:58:32 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:32.131Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=93 Dec 20 18:58:32 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:32.432Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:32 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:32.733Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=198 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.033Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=195 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.334Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.593Z level=INFO msg="new address was allocated" component=conn/ble old=159 new=160 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.635Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=243 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.635Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=124 chunks=1 index=0 Dec 20 18:58:33 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:33.936Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=115 Dec 20 18:58:34 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:34.237Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=68 Dec 20 18:58:34 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:34.537Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=164 Dec 20 18:58:34 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:34.839Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:58:34 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:34.839Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=39 chunks=1 index=0 Dec 20 18:58:34 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:34.839Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=33 chunks=1 index=0 Dec 20 18:58:35 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:35.140Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=227 Dec 20 18:58:35 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:35.212Z level=INFO msg="new address was allocated" component=conn/ble old=160 new=161 Dec 20 18:58:35 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:35.441Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=92 Dec 20 18:58:35 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:35.742Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=189 Dec 20 18:58:36 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:36.042Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=14 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPlay Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::play index undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::startPlaybackTimer Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: ControllerMpd::resume Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::sendMpdCommand play Dec 20 18:58:36 rivo-plus volumio[3213]: info: Dec 20 18:58:36 rivo-plus volumio[3213]: ---------------------------- MPD announces state update: player Dec 20 18:58:36 rivo-plus volumio[3213]: info: sendMpdCommand play took 18 milliseconds Dec 20 18:58:36 rivo-plus volumio[3213]: info: ControllerMpd::getState Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:58:36 rivo-plus volumio[3213]: info: Dec 20 18:58:36 rivo-plus volumio[3213]: ---------------------------- MPD announces state update: player Dec 20 18:58:36 rivo-plus volumio[3213]: info: ControllerMpd::getState Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:58:36 rivo-plus volumio[3213]: info: sendMpdCommand status took 4 milliseconds Dec 20 18:58:36 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:36.344Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=33 Dec 20 18:58:36 rivo-plus volumio[3213]: info: sendMpdCommand status took 5 milliseconds Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::parseState Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::parseState Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:58:36 rivo-plus volumio[3213]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 18:58:36 rivo-plus volumio[3213]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:58:36 rivo-plus volumio[3213]: info: ControllerMpd::pushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::servicePushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125725,"duration":303,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1513 Kbps","isStreaming":false,"title":"Text Book","artist":"Lana Del Rey","album":"Blue Banisters","uri":"USB/WDW/Lana Del Rey/Lana Del Rey - 2021 - Blue Banisters [MQA]/01 Text Book.mqa.flac","trackType":"flac"} Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: CURRENT POSITION 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::syncState stateService play Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::syncState currentStatus pause Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:36 rivo-plus volumio[3213]: info: ControllerMpd::pushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::servicePushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125725,"duration":303,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1513 Kbps","isStreaming":false,"title":"Text Book","artist":"Lana Del Rey","album":"Blue Banisters","uri":"USB/WDW/Lana Del Rey/Lana Del Rey - 2021 - Blue Banisters [MQA]/01 Text Book.mqa.flac","trackType":"flac"} Dec 20 18:58:36 rivo-plus volumio[3213]: verbose: CURRENT POSITION 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::syncState stateService play Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:58:36 rivo-plus volumio[3213]: info: Received an update from plugin. extracting info from payload Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:36 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:36 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:36 rivo-plus volumio[3213]: info: ------------------------------ 90ms Dec 20 18:58:36 rivo-plus volumio[3213]: info: ------------------------------ 75ms Dec 20 18:58:36 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:36 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:36 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:36 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:36 rivo-plus volumio[3213]: info: MCU Signalled Playback Active Dec 20 18:58:36 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:36.644Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=198 Dec 20 18:58:36 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:36.765Z level=INFO msg="new address was allocated" component=conn/ble old=161 new=162 Dec 20 18:58:36 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:36.945Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=131 Dec 20 18:58:37 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:37.247Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:37 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:37.548Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:37 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:37.848Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=185 Dec 20 18:58:38 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:38.149Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=185 Dec 20 18:58:38 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:38.150Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=105 chunks=1 index=0 Dec 20 18:58:38 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:38.451Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=47 Dec 20 18:58:38 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:38.452Z level=INFO msg="new address was allocated" component=conn/ble old=162 new=163 Dec 20 18:58:38 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:38.752Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=117 Dec 20 18:58:39 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:39.053Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=144 Dec 20 18:58:39 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:39.355Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=93 Dec 20 18:58:39 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:39.655Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=254 Dec 20 18:58:39 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:39.956Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=82 Dec 20 18:58:40 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:40.257Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=210 Dec 20 18:58:40 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:40.478Z level=INFO msg="new address was allocated" component=conn/ble old=163 new=164 Dec 20 18:58:40 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:40.559Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=4 Dec 20 18:58:40 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:40.859Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=42 Dec 20 18:58:41 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:41.161Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=135 Dec 20 18:58:41 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:41.461Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:58:41 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:41.762Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=15 Dec 20 18:58:41 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:41.828Z level=INFO msg="new address was allocated" component=conn/ble old=164 new=165 Dec 20 18:58:42 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:42.064Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=16 Dec 20 18:58:42 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:42.364Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:42 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:42.666Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=99 Dec 20 18:58:42 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:42.967Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=169 Dec 20 18:58:43 rivo-plus volumio[3213]: info: VolumeController::SetAlsaVolume84 Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:43 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:43 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:43 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:43 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Dec 20 18:58:43 rivo-plus volumio[3213]: xcb_connection_has_error() returned true Dec 20 18:58:43 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:43.268Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=218 Dec 20 18:58:43 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:43.569Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=127 Dec 20 18:58:43 rivo-plus volumio[3213]: info: VolumeController::SetAlsaVolume87 Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:43 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:43 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:43 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:43 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:43 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:43 rivo-plus volumio[3213]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Dec 20 18:58:43 rivo-plus volumio[3213]: xcb_connection_has_error() returned true Dec 20 18:58:43 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:43.785Z level=INFO msg="new address was allocated" component=conn/ble old=165 new=166 Dec 20 18:58:43 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:43.870Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=68 Dec 20 18:58:44 rivo-plus volumio[3213]: info: VolumeController::SetAlsaVolume0 Dec 20 18:58:44 rivo-plus volumio[3213]: info: CoreStateMachine::pushState Dec 20 18:58:44 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:44 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:58:44 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioPushState Dec 20 18:58:44 rivo-plus volumio[3213]: info: CoreCommandRouter::volumioGetState Dec 20 18:58:44 rivo-plus volumio[3213]: info: CorePlayQueue::getTrack 0 Dec 20 18:58:44 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output update for this device Dec 20 18:58:44 rivo-plus volumio[3213]: info: MRS: Pushing multiroomSync output Dec 20 18:58:44 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:44.171Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=166 Dec 20 18:58:44 rivo-plus volumio[3213]: info: Signalling Playback active due to playback status change Dec 20 18:58:44 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:44 rivo-plus volumio[3213]: info: Updating RAAT Signal Path Dec 20 18:58:44 rivo-plus volumio[3213]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 18:58:44 rivo-plus volumio[3213]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Dec 20 18:58:44 rivo-plus volumio[3213]: xcb_connection_has_error() returned true Dec 20 18:58:44 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:44.472Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:58:44 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:44.772Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=189 Dec 20 18:58:45 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:45.072Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=76 Dec 20 18:58:45 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:45.373Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=232 Dec 20 18:58:45 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:45.674Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=162 Dec 20 18:58:45 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:45.810Z level=INFO msg="new address was allocated" component=conn/ble old=166 new=167 Dec 20 18:58:45 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:45.974Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=50 Dec 20 18:58:46 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:46.275Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=114 Dec 20 18:58:46 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:46.575Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=248 Dec 20 18:58:46 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:46.876Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=175 Dec 20 18:58:47 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:47.177Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=195 Dec 20 18:58:47 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Dec 20 18:58:47 rivo-plus volumio[3213]: info: MRS: Setting this device as single Dec 20 18:58:47 rivo-plus volumio[3213]: info: Dec 20 18:58:47 rivo-plus volumio[3213]: [1766249927244] ---------------------------- Setting Multiroom Single Dec 20 18:58:47 rivo-plus volumio[3213]: info: MRS: disable multiroom output Dec 20 18:58:47 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioDiscard Dec 20 18:58:47 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Dec 20 18:58:47 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:47.478Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=114 Dec 20 18:58:47 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:47.632Z level=INFO msg="new address was allocated" component=conn/ble old=167 new=168 Dec 20 18:58:47 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:47.780Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=17 Dec 20 18:58:47 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Dec 20 18:58:48 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Dec 20 18:58:48 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:48.080Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=17 Dec 20 18:58:48 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:48.380Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=88 Dec 20 18:58:48 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:48.681Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=228 Dec 20 18:58:48 rivo-plus volumio[3213]: info: MRS: STOPPING volumioStreaming Dec 20 18:58:48 rivo-plus sudo[32048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 20 18:58:48 rivo-plus sudo[32048]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:48 rivo-plus systemd[1]: Stopping VolumioStreamingService... Dec 20 18:58:48 rivo-plus systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Dec 20 18:58:48 rivo-plus sudo[32051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream7.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Dec 20 18:58:48 rivo-plus sudo[32051]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:58:48 rivo-plus volumio[3213]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 18:58:48 rivo-plus systemd[1]: volumioStreaming.service: Succeeded. Dec 20 18:58:48 rivo-plus systemd[1]: Stopped VolumioStreamingService. Dec 20 18:58:48 rivo-plus sudo[32051]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:48 rivo-plus sudo[32048]: pam_unix(sudo:session): session closed for user root Dec 20 18:58:48 rivo-plus volumio[3213]: info: MRS: Removed streaming files Dec 20 18:58:48 rivo-plus volumio[3213]: info: MRS: volumioStreaming STOPPED Dec 20 18:58:48 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:48.982Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=161 Dec 20 18:58:48 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:48.982Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=182 chunks=1 index=0 Dec 20 18:58:49 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:49.050Z level=INFO msg="new address was allocated" component=conn/ble old=168 new=169 Dec 20 18:58:49 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:49.283Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=237 Dec 20 18:58:49 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:49.584Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:58:49 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:49.885Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=205 Dec 20 18:58:50 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:50.185Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=244 Dec 20 18:58:50 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:50.485Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=82 Dec 20 18:58:50 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:50.787Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=249 Dec 20 18:58:50 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:50.872Z level=INFO msg="new address was allocated" component=conn/ble old=169 new=170 Dec 20 18:58:51 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:51.088Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=99 Dec 20 18:58:51 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:51.388Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=3 Dec 20 18:58:51 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:51.690Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=63 Dec 20 18:58:51 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:51.991Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:52 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:52.291Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=74 Dec 20 18:58:52 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:52.425Z level=INFO msg="new address was allocated" component=conn/ble old=170 new=171 Dec 20 18:58:52 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:52.592Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=225 Dec 20 18:58:52 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:52.893Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=5 Dec 20 18:58:53 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:53.194Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=83 Dec 20 18:58:53 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:53.494Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=234 Dec 20 18:58:53 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:53.795Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=188 Dec 20 18:58:53 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:53.795Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=86 chunks=1 index=0 Dec 20 18:58:54 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:54.095Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=2 Dec 20 18:58:54 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:54.112Z level=INFO msg="new address was allocated" component=conn/ble old=171 new=172 Dec 20 18:58:54 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:54.397Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=54 Dec 20 18:58:54 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:54.697Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:54 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:54.997Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=47 Dec 20 18:58:55 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:55.298Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=100 Dec 20 18:58:55 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:55.599Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:55 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:55.900Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=147 Dec 20 18:58:56 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:56.138Z level=INFO msg="new address was allocated" component=conn/ble old=172 new=173 Dec 20 18:58:56 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:56.201Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:58:56 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:56.502Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=79 Dec 20 18:58:56 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:56.803Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=106 Dec 20 18:58:56 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:56.803Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=36 chunks=2 index=0 Dec 20 18:58:57 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:57.104Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=237 Dec 20 18:58:57 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:57.352Z level=INFO msg="new address was allocated" component=conn/ble old=173 new=174 Dec 20 18:58:57 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:57.405Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=137 Dec 20 18:58:57 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:57.706Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:58:58 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:58.007Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=159 Dec 20 18:58:58 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:58.308Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:58:58 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:58.608Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=19 Dec 20 18:58:58 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:58.608Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=163 chunks=1 index=0 Dec 20 18:58:58 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:58.909Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:58:59 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:59.209Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=195 Dec 20 18:58:59 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:59.445Z level=INFO msg="new address was allocated" component=conn/ble old=174 new=175 Dec 20 18:58:59 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:59.510Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=172 Dec 20 18:58:59 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:58:59.811Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=204 Dec 20 18:59:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:00.111Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=70 Dec 20 18:59:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:00.412Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=102 Dec 20 18:59:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:00.713Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=237 Dec 20 18:59:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:00.713Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=51 chunks=1 index=0 Dec 20 18:59:00 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:00.795Z level=INFO msg="new address was allocated" component=conn/ble old=175 new=176 Dec 20 18:59:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:01.014Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=69 Dec 20 18:59:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:01.315Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=39 Dec 20 18:59:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:01.616Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=86 Dec 20 18:59:01 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:01.917Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=30 Dec 20 18:59:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:02.218Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=146 Dec 20 18:59:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:02.415Z level=INFO msg="new address was allocated" component=conn/ble old=176 new=177 Dec 20 18:59:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:02.518Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=35 Dec 20 18:59:02 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:02.819Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:59:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:03.121Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=103 Dec 20 18:59:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:03.421Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=17 Dec 20 18:59:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:03.722Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=1 Dec 20 18:59:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:03.723Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=100 chunks=1 index=0 Dec 20 18:59:03 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:03.765Z level=INFO msg="new address was allocated" component=conn/ble old=177 new=178 Dec 20 18:59:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:04.023Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=156 Dec 20 18:59:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:04.324Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=199 Dec 20 18:59:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:04.625Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=99 Dec 20 18:59:04 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:04.926Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=219 Dec 20 18:59:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:05.226Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=30 Dec 20 18:59:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:05.520Z level=INFO msg="new address was allocated" component=conn/ble old=178 new=179 Dec 20 18:59:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:05.527Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=198 Dec 20 18:59:05 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:05.827Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:59:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:06.128Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=165 Dec 20 18:59:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:06.429Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=210 Dec 20 18:59:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:06.730Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=228 Dec 20 18:59:06 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:06.735Z level=INFO msg="new address was allocated" component=conn/ble old=179 new=180 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.032Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=154 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.032Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=228 chunks=1 index=0 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.332Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=222 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.332Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=153 chunks=1 index=0 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.633Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=5 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.934Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=165 Dec 20 18:59:07 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:07.935Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=131 chunks=1 index=0 Dec 20 18:59:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:08.235Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=137 Dec 20 18:59:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:08.355Z level=INFO msg="new address was allocated" component=conn/ble old=180 new=181 Dec 20 18:59:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:08.536Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=173 Dec 20 18:59:08 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:08.836Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=184 Dec 20 18:59:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:09.138Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=45 Dec 20 18:59:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:09.439Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=124 Dec 20 18:59:09 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:09.740Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=40 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.041Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=30 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.041Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=48 chunks=1 index=0 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.342Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=248 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.380Z level=INFO msg="new address was allocated" component=conn/ble old=181 new=182 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.642Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=36 Dec 20 18:59:10 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:10.943Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=24 Dec 20 18:59:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:11.243Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=16 Dec 20 18:59:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:11.545Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=134 Dec 20 18:59:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:11.846Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=109 Dec 20 18:59:11 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:11.932Z level=INFO msg="new address was allocated" component=conn/ble old=182 new=183 Dec 20 18:59:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:12.146Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=2 Dec 20 18:59:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:12.447Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:59:12 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:12.749Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=193 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.049Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=155 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.049Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=178 chunks=1 index=0 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.350Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=24 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.620Z level=INFO msg="new address was allocated" component=conn/ble old=183 new=184 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.650Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=238 Dec 20 18:59:13 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:13.951Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=255 Dec 20 18:59:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:14.252Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=116 Dec 20 18:59:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:14.553Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=74 Dec 20 18:59:14 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:14.854Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=177 Dec 20 18:59:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:15.105Z level=INFO msg="new address was allocated" component=conn/ble old=184 new=185 Dec 20 18:59:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:15.155Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:59:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:15.456Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=231 Dec 20 18:59:15 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:15.757Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=99 Dec 20 18:59:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:16.058Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=163 Dec 20 18:59:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:16.359Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=58 Dec 20 18:59:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:16.658Z level=INFO msg="new address was allocated" component=conn/ble old=185 new=186 Dec 20 18:59:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:16.659Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:59:16 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:16.960Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=224 Dec 20 18:59:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:17.261Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=221 Dec 20 18:59:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:17.562Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=228 Dec 20 18:59:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:17.864Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=166 Dec 20 18:59:17 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:17.872Z level=INFO msg="new address was allocated" component=conn/ble old=186 new=187 Dec 20 18:59:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:18.165Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=20 Dec 20 18:59:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:18.465Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=4 Dec 20 18:59:18 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:18.766Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=246 Dec 20 18:59:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:19.067Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=51 Dec 20 18:59:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:19.369Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=68 Dec 20 18:59:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:19.670Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=112 Dec 20 18:59:19 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:19.970Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=184 Dec 20 18:59:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:20.272Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=184 Dec 20 18:59:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:20.370Z level=INFO msg="new address was allocated" component=conn/ble old=187 new=188 Dec 20 18:59:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:20.572Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=180 Dec 20 18:59:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:20.572Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=106 chunks=1 index=0 Dec 20 18:59:20 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:20.874Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=166 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.174Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=16 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.474Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=140 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.475Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=189 chunks=1 index=0 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.475Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=40 chunks=1 index=0 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.475Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=43 chunks=1 index=0 Dec 20 18:59:21 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:21.775Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=150 Dec 20 18:59:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:22.058Z level=INFO msg="new address was allocated" component=conn/ble old=188 new=189 Dec 20 18:59:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:22.076Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=254 Dec 20 18:59:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:22.376Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=189 Dec 20 18:59:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:22.678Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=29 Dec 20 18:59:22 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:22.979Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=103 Dec 20 18:59:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:23.279Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=115 Dec 20 18:59:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:23.408Z level=INFO msg="new address was allocated" component=conn/ble old=189 new=190 Dec 20 18:59:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:23.580Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=27 Dec 20 18:59:23 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:23.880Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:59:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:24.182Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=165 Dec 20 18:59:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:24.483Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=102 Dec 20 18:59:24 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:24.784Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=123 Dec 20 18:59:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:25.085Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=114 Dec 20 18:59:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:25.387Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=71 Dec 20 18:59:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:25.433Z level=INFO msg="new address was allocated" component=conn/ble old=190 new=191 Dec 20 18:59:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:25.687Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=153 Dec 20 18:59:25 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:25.988Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=215 Dec 20 18:59:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:26.289Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=111 Dec 20 18:59:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:26.590Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=75 Dec 20 18:59:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:26.890Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:59:26 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:26.985Z level=INFO msg="new address was allocated" component=conn/ble old=191 new=192 Dec 20 18:59:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:27.191Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=139 Dec 20 18:59:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:27.492Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=206 Dec 20 18:59:27 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:27.793Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=246 Dec 20 18:59:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:28.094Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=161 Dec 20 18:59:28 rivo-plus volumio[3213]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: Starting cast device: Q990D-820a56b2a7a49ee5e42b07ca242ba083 Dec 20 18:59:28 rivo-plus volumio[3213]: info: Enabled audio output: Q990D-820a56b2a7a49ee5e42b07ca242ba083 Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: Setting this device as Streaming Server Dec 20 18:59:28 rivo-plus volumio[3213]: info: Dec 20 18:59:28 rivo-plus volumio[3213]: [1766249968370] ---------------------------- MRS: Setting Streaming Server Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: enable multiroom server output Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioMultiRoom Dec 20 18:59:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:28.395Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=66 Dec 20 18:59:28 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Dec 20 18:59:28 rivo-plus volumio[3213]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: STARTING volumioStreaming Dec 20 18:59:28 rivo-plus sudo[32180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 18:59:28 rivo-plus sudo[32180]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:59:28 rivo-plus sudo[32180]: pam_unix(sudo:session): session closed for user root Dec 20 18:59:28 rivo-plus sudo[32183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Dec 20 18:59:28 rivo-plus sudo[32183]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: Connected to cast device: Q990D-820a56b2a7a49ee5e42b07ca242ba083 Dec 20 18:59:28 rivo-plus systemd[1]: Started VolumioStreamingService. Dec 20 18:59:28 rivo-plus sudo[32183]: pam_unix(sudo:session): session closed for user root Dec 20 18:59:28 rivo-plus volumio[3213]: info: MRS: volumioStreaming STARTED Dec 20 18:59:28 rivo-plus sudo[32189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 18:59:28 rivo-plus volumio[3213]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:59:28 rivo-plus sudo[32189]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 18:59:28 rivo-plus sudo[32189]: pam_unix(sudo:session): session closed for user root Dec 20 18:59:28 rivo-plus volumio[3213]: TypeError: Cannot read property 'on' of undefined Dec 20 18:59:28 rivo-plus volumio[3213]: at /volumio/app/plugins/audio_interface/multiroom/multiroom_real:1:29834 Dec 20 18:59:28 rivo-plus volumio[3213]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:95:20 Dec 20 18:59:28 rivo-plus volumio[3213]: at /volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/receiver.js:51:14 Dec 20 18:59:28 rivo-plus volumio[3213]: at fn.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/request-response.js:27:7) Dec 20 18:59:28 rivo-plus volumio[3213]: at fn.emit (events.js:412:35) Dec 20 18:59:28 rivo-plus volumio[3213]: at Channel.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/controllers/controller.js:16:10) Dec 20 18:59:28 rivo-plus volumio[3213]: at Channel.emit (events.js:400:28) Dec 20 18:59:28 rivo-plus volumio[3213]: at Client.onmessage (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/channel.js:23:10) Dec 20 18:59:28 rivo-plus volumio[3213]: at Client.emit (events.js:412:35) Dec 20 18:59:28 rivo-plus volumio[3213]: at PacketStreamWrapper.onpacket (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:81:10) Dec 20 18:59:28 rivo-plus volumio[3213]: at PacketStreamWrapper.emit (events.js:400:28) Dec 20 18:59:28 rivo-plus volumio[3213]: at TLSSocket. (/volumio/app/plugins/audio_interface/multiroom/node_modules/castv2/lib/packet-stream-wrapper.js:28:16) Dec 20 18:59:28 rivo-plus volumio[3213]: at TLSSocket.emit (events.js:400:28) Dec 20 18:59:28 rivo-plus volumio[3213]: at emitReadable_ (internal/streams/readable.js:555:12) Dec 20 18:59:28 rivo-plus volumio[3213]: at processTicksAndRejections (internal/process/task_queues.js:81:21) Dec 20 18:59:28 rivo-plus volumio[3213]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:59:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:28.701Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=110 Dec 20 18:59:28 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:28.740Z level=INFO msg="new address was allocated" component=conn/ble old=192 new=193 Dec 20 18:59:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:29.003Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=252 Dec 20 18:59:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:29.304Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=228 Dec 20 18:59:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:29.605Z level=WARN msg="pending write acknowledgment timed out, retrying" component=conn/ble addr=42 Dec 20 18:59:29 rivo-plus volumio5-onboarding[4008]: time=2025-12-20T16:59:29.605Z level=ERROR msg="pending write exceeded maximum retries, dropping" component=conn/ble addr=147 chunks=1 index=0 Dec 20 18:59:29 rivo-plus sudo[32209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 18:58 Dec 20 18:59:29 rivo-plus sudo[32209]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"