RHEOS - creepy volume

I really appreciate RHEOS!

Weirdly, after I’ve raised the volume (to 45 let’s say) and played a few tracks, clicking on a new track in the Roon player (on MacOS) causes the HEOS volume to decline slowly to 24.

What could possibly be causing this?

That’s definitely a little weird!

Could you let me know your set up.

We may need to see what’s happening in your log files.

In fact I may need to add something to the logging to better understand.

Thanks for reporting the issue. I’ve not seen it before.

Peter

Noticed this is a Mac set up.

What version of RHEOS are you on?

Sure — here’s some info on the setup:

  • Roon remote v2.0 build 1280 - MacOS
  • Roon core v2.0 build 1280 - Win10
  • RHEOS v0.6.5-17 - DietPi 8.18.2 - Raspberry Pi 400

I’ve seen this behavior a few times in the last couple months. LMK if you’d like some clips from the logs.

monty

Here’s an example, I was just able to reproduce the issue:

That would be definitely helpful - please note time and what’s playing when it happens - then I can see if there’s anything to see.

Screen recording very helpful.

I’ll investigate.

@peter_richardson any update?

In case it helps, I’m seeing a lot of RHEOS in the logs. (Is this normal?)

06/20 20:53:58 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 52 minutes 41 seconds \n”}
06/20 20:54:01 Debug: [easyhttp] [708] POST to https://api.roonlabs.net/device-map/1/register returned after 114 ms, status code: 200, request body size: 10 KB
06/20 20:54:01 Trace: [devicemap] device map updated
06/20 20:54:03 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 52 minutes 46 seconds \n”}
06/20 20:54:08 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 52 minutes 51 seconds \n”}
06/20 20:54:13 Info: [stats] 2122649mb Virtual, 1841mb Physical, 1334mb Managed, 2059 Handles, 103 Threads
06/20 20:54:13 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 52 minutes 56 seconds \n”}
06/20 20:54:18 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 1 second \n”}
06/20 20:54:23 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 6 seconds \n”}
06/20 20:54:28 Info: [stats] 2122632mb Virtual, 1840mb Physical, 1431mb Managed, 2052 Handles, 92 Threads
06/20 20:54:28 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 11 seconds \n”}
06/20 20:54:33 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 16 seconds \n”}
06/20 20:54:38 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 21 seconds \n”}
06/20 20:54:40 Trace: [roonapi] [apiclient 10.10.1.9:52126] CONTINUE Changed {“message”:“Extension Repository loaded (v1.0.15)”,“is_error”:false}
06/20 20:54:43 Info: [stats] 2122632mb Virtual, 1840mb Physical, 1435mb Managed, 2054 Handles, 92 Threads
06/20 20:54:43 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 26 seconds \n”}
06/20 20:54:48 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 31 seconds \n”}
06/20 20:54:53 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 36 seconds \n”}
06/20 20:54:58 Info: [stats] 2122629mb Virtual, 1841mb Physical, 1230mb Managed, 2032 Handles, 90 Threads
06/20 20:54:58 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 41 seconds \n”}
06/20 20:55:03 Trace: [broker/accounts] [heartbeat] now=6/21/2023 1:55:03 AM nextauthrefresh=6/21/2023 2:20:03 AM nextmachineallocate=6/21/2023 2:10:03 AM
06/20 20:55:03 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 46 seconds \n”}
06/20 20:55:08 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 51 seconds \n”}
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘Checking’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘Checking’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘Checking’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:10 Debug: [base/updater] Checking for updates: https://updates.roonlabs.com/update/?v=2&serial=9562B998-EFC3-4C3A-BFCB-F7C75C2D4A6D&userid=f8b94276-c640-4763-9ae1-533107f2d172&platform=windows64&product=RoonServer&branding=roon&curbranch=earlyaccess&version=200001280&branch=earlyaccess&coredeviceid=750b1e40-3923-4956-92a8-f3154e29284c&deviceid=750b1e40-3923-4956-92a8-f3154e29284c&osversion=Windows+10&os64bit=true
06/20 20:55:10 Debug: [easyhttp] [709] GET to https://api.roonlabs.net/updates/update/?v=2&serial=9562B998-EFC3-4C3A-BFCB-F7C75C2D4A6D&userid=f8b94276-c640-4763-9ae1-533107f2d172&platform=windows64&product=RoonServer&branding=roon&curbranch=earlyaccess&version=200001280&branch=earlyaccess&coredeviceid=750b1e40-3923-4956-92a8-f3154e29284c&deviceid=750b1e40-3923-4956-92a8-f3154e29284c&osversion=Windows+10&os64bit=true returned after 200 ms, status code: 204, request body size: 0 B
06/20 20:55:10 Debug: [appupdater] Update not needed
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘UpToDate’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘UpToDate’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:10 Trace: [remoting/remotingserverv2] SENT NONFINAL DistributedBroker.UpdatesChangedResponse={ IsSupported=True WasJustUpdated=False Status=‘UpToDate’ HasChangeLog=False CurrentVersion={ MachineValue=200001280 DisplayValue=‘2.0 (build 1280) earlyaccess’ Branch=‘earlyaccess’ } }
06/20 20:55:13 Info: [stats] 2122655mb Virtual, 1842mb Physical, 1241mb Managed, 2110 Handles, 107 Threads
06/20 20:55:13 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 53 minutes 56 seconds \n”}
06/20 20:55:18 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 1 second \n”}
06/20 20:55:23 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 6 seconds \n”}
06/20 20:55:28 Info: [stats] 2122632mb Virtual, 1842mb Physical, 1346mb Managed, 2088 Handles, 92 Threads
06/20 20:55:28 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 11 seconds \n”}
06/20 20:55:33 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 16 seconds \n”}
06/20 20:55:38 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 21 seconds \n”}
06/20 20:55:40 Trace: [roonapi] [apiclient 10.10.1.9:52126] CONTINUE Changed {“message”:“Extension Repository loaded (v1.0.15)”,“is_error”:false}
06/20 20:55:43 Info: [stats] 2122635mb Virtual, 1842mb Physical, 1363mb Managed, 2114 Handles, 94 Threads
06/20 20:55:43 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 26 seconds \n”}
06/20 20:55:48 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 31 seconds \n”}
06/20 20:55:53 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 36 seconds \n”}
06/20 20:55:58 Info: [stats] 2122632mb Virtual, 1842mb Physical, 1444mb Managed, 2117 Handles, 92 Threads
06/20 20:55:58 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 41 seconds \n”}
06/20 20:56:03 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 46 seconds \n”}
06/20 20:56:08 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 51 seconds \n”}
06/20 20:56:13 Info: [stats] 2122653mb Virtual, 1843mb Physical, 1495mb Managed, 2184 Handles, 106 Threads
06/20 20:56:13 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 54 minutes 56 seconds \n”}
06/20 20:56:18 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 1 second \n”}
06/20 20:56:23 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 6 seconds \n”}
06/20 20:56:28 Info: [stats] 2122637mb Virtual, 1847mb Physical, 1323mb Managed, 2028 Handles, 95 Threads
06/20 20:56:28 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 11 seconds \n”}
06/20 20:56:33 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 16 seconds \n”}
06/20 20:56:38 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 21 seconds \n”}
06/20 20:56:40 Trace: [roonapi] [apiclient 10.10.1.9:52126] CONTINUE Changed {“message”:“Extension Repository loaded (v1.0.15)”,“is_error”:false}
06/20 20:56:43 Info: [stats] 2122634mb Virtual, 1847mb Physical, 1337mb Managed, 2030 Handles, 93 Threads
06/20 20:56:43 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 26 seconds \n”}
06/20 20:56:48 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 31 seconds \n”}
06/20 20:56:53 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 36 seconds \n”}
06/20 20:56:58 Info: [stats] 2122635mb Virtual, 1847mb Physical, 1429mb Managed, 2039 Handles, 94 Threads
06/20 20:56:58 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 41 seconds \n”}
06/20 20:57:03 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 46 seconds \n”}
06/20 20:57:08 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 51 seconds \n”}
06/20 20:57:13 Info: [stats] 2122652mb Virtual, 1848mb Physical, 1457mb Managed, 2106 Handles, 105 Threads
06/20 20:57:13 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 55 minutes 56 seconds \n”}
06/20 20:57:18 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 1 second \n”}
06/20 20:57:23 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 6 seconds \n”}
06/20 20:57:28 Info: [stats] 2122632mb Virtual, 1847mb Physical, 1260mb Managed, 2087 Handles, 92 Threads
06/20 20:57:28 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 11 seconds \n”}
06/20 20:57:33 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 16 seconds \n”}
06/20 20:57:38 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 21 seconds \n”}
06/20 20:57:40 Trace: [roonapi] [apiclient 10.10.1.9:52126] CONTINUE Changed {“message”:“Extension Repository loaded (v1.0.15)”,“is_error”:false}
06/20 20:57:43 Info: [stats] 2122634mb Virtual, 1847mb Physical, 1278mb Managed, 2091 Handles, 93 Threads
06/20 20:57:43 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 26 seconds \n”}
06/20 20:57:48 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 31 seconds \n”}
06/20 20:57:53 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 36 seconds \n”}
06/20 20:57:58 Info: [stats] 2122632mb Virtual, 1847mb Physical, 1353mb Managed, 2096 Handles, 92 Threads
06/20 20:57:58 Trace: [roonapi] [apiclient 10.10.1.9:43228] CONTINUE Changed {“message”:“9 HEOS Players on DietPi linux arm64 at 10.10.1.9 for 12 days 56 minutes 41 seconds \n”}

Nothing unusual in the ROON logs. The ‘noise’ is the update every 5 seconds to the status information.

The logs of potential interest are from the extension manager. There’s an option to collect the log in the drop down for extension manager. Please see if you can collect these and share with me.

I’ve been unable to replicate this in my own system, unfortunately, this makes it harder to debug!.

A few questions as I look at the code and think what may be causing this unusual problem:

Does it persist if you stop the app and restart from extension manager?

If you reinstall does that similarly have an effect?

Does this effect all your Heos players or is it “kitchen” only?

Is “kitchen” hard wired or on wifi? What model device is it?

Thanks @peter_richardson, I figured out how to get RHEOS logs. See below.

(FWIW this happens on all HEOS devices - I have two HEOS Drive units / 8 zones, with hard-wired ethernet including Roon core, RHEOS, and HEOS boxes.)

Logs from this afternoon. The volume-decline issue just happened about 10 min ago (timestamp 17:20), when I connected my MacBook and started playing music in the Kitchen zone. (I then quit, installed Roon update, and restarted the MacOS client.)

2023-07-03T17:19:57.368321000Z ZONES ADDED [ ‘Macbook Pro 16’ ]
2023-07-03T17:19:57.370540000Z NO VARIABLE GROUP FOUND
2023-07-03T17:19:57.874749000Z ZONES CHANGED [ ‘Naim’ ]
2023-07-03T17:19:57.875443000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:04.388023000Z Kitchen null
2023-07-03T17:20:04.389425000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:04.390069000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:04.390942000Z 7/3/2023, 5:20:04 PM Kitchen :arrow_forward: The Same - The Smile
2023-07-03T17:20:05.259869000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:05.260658000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:05.787513000Z Kitchen 0
2023-07-03T17:20:06.322786000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:06.323525000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:06.853915000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:06.856066000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:07.362846000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:07.363861000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:07.893160000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:07.894631000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:07.970940000Z PLAYER STATE CHANGED Kitchen play
2023-07-03T17:20:08.416132000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:08.416844000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:08.978718000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:08.980826000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:09.505185000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:09.505900000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:10.037681000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:10.039831000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:10.565626000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:10.566526000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:11.109529000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:11.111730000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:11.645120000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:11.645846000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:12.189191000Z Kitchen 1
2023-07-03T17:20:12.191436000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:12.191804000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:12.720227000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:12.720913000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:13.256048000Z Kitchen 2
2023-07-03T17:20:13.258002000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:13.258532000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:13.782326000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:13.783073000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:14.323071000Z Kitchen 3
2023-07-03T17:20:14.325085000Z ZONES CHANGED [ ‘Kitchen’ ]
2023-07-03T17:20:14.325449000Z NO VARIABLE GROUP FOUND
2023-07-03T17:20:14.835946000Z Kitchen 4
2023-07-03T17:20:15.800071000Z Kitchen 5
2023-07-03T17:20:16.812474000Z Kitchen 6
2023-07-03T17:20:17.809018000Z Kitchen 7
2023-07-03T17:20:18.810123000Z Kitchen 8
2023-07-03T17:20:19.810376000Z Kitchen 9
2023-07-03T17:20:20.811349000Z Kitchen 10
2023-07-03T17:20:21.812800000Z Kitchen 11
2023-07-03T17:20:22.815373000Z Kitchen 12
2023-07-03T17:20:23.808979000Z Kitchen 13
2023-07-03T17:20:24.810319000Z Kitchen 14
2023-07-03T17:20:25.807465000Z Kitchen 15
2023-07-03T17:20:26.808903000Z Kitchen 16
2023-07-03T17:20:27.803117000Z Kitchen 17
2023-07-03T17:20:28.804371000Z Kitchen 18
2023-07-03T17:20:29.805514000Z Kitchen 19
2023-07-03T17:20:30.810385000Z Kitchen 20
2023-07-03T17:20:31.792083000Z Kitchen 21
2023-07-03T17:20:32.791286000Z Kitchen 22
2023-07-03T17:20:33.809863000Z Kitchen 23

Thank you.

That’s fascinating - you can see it changing in volume. Now I need to work out why. I’ve made some changes to the volume control sections in the app and should be able to release for testing next week along with a couple of new features for volume control of AVR zones.

Appreciate your patience.

Peter

Peter - is that what those “Kitchen nn” log entries are indicating? It’s quite rhythmic, almost exactly one event per second, at least after the 17:20:15 event….

Here’s related Roon Server logs at the same timestamp (clocks seem to be offset by 00:00:20). You can see the change volume commands coming through like this:

07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:57}
07/03 12:20:36 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=56 dvc=1 preamp=255 newvol=5632
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:56}
07/03 12:20:36 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=54 dvc=1 preamp=255 newvol=5376

More context below.

monty

07/03 12:20:35 Info: [Kitchen] [zoneplayer] Open Result (Playing):Result[Status=Success]
07/03 12:20:35 Trace: [squeezebox/client] [10.10.1.9:38938] SENT strm command=q autostart=0 formatbyte=p pcmsamplesize=1 pcmsamplerate=3 pcmchannels=2 pcmendian=1 threshold=0 spdif_enable=0 trans_period=0 trans_type=0, flags=0, output_threshold=0, replay_gain=0, http_header=
07/03 12:20:35 Info: [Kitchen] [zoneplayer] Starting playback
07/03 12:20:35 Trace: [squeezebox/client] [10.10.1.9:38938] SENT strm command=s autostart=1 formatbyte=f pcmsamplesize=? pcmsamplerate=? pcmchannels=? pcmendian=? threshold=255 spdif_enable=0 trans_period=0 trans_type=0, flags=0, output_threshold=0, replay_gain=0, http_header=GET /280d282644ec480e884968270926ac79 HTTP/1.0

07/03 12:20:35 Info: [zone Kitchen] OnPlayFeedback Playing
07/03 12:20:35 Debug: Lastfm ‘MuuEaGLFsIEkwpJBOTw4UfMph6MtgYqg’ START: The Smile - The Same
07/03 12:20:35 Trace: [Kitchen] [Lossless, 24/44 QOBUZ FLAC => 24/44] [PLAYING @ 0:00] The Same - The Smile
07/03 12:20:35 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“zones_changed”:[{“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“display_name”:“Kitchen”,“outputs”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:58,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}],“state”:“playing”,“is_next_allowed”:true,“is_previous_allowed”:true,“is_pause_allowed”:true,“is_play_allowed”:false,“is_seek_allowed”:true,“queue_items_remaining”:13,“queue_time_remaining”:3198,“settings”:{“loop”:“disabled”,“shuffle”:false,“auto_radio”:false},“now_playing”:{“seek_position”:null,“length”:259,“one_line”:{“line1”:“The Same - The Smile”},“two_line”:{“line1”:“The Same”,“line2”:“The Smile”},“three_line”:{“line1”:“The Same”,“line2”:“The Smile”,“line3”:“A Light for Attracting Attention”},“image_key”:“53254906a61a78a8a6c33060265a867e”,“artist_image_keys”:[“fc3ff4ef318cc77ac1aff1be2f500c7d”]}}]}
07/03 12:20:35 Trace: [squeezebox/client] [10.10.1.9:38938] GOT STAT event_code=STMf crlf_count=0 mas_initialized= mas_mode=0 buffer_size=524280 fullness=0 bytes_received=0 wireless_signal=65535 jiffies=482657928 output_buffer_size=262144 output_buffer_fullness=131072 elapsed_seconds=0 voltage=0 elapsed_milliseconds=0 server_timestamp=0 error_code=0
07/03 12:20:35 Trace: [prebuffer] ready 149940/441000 (34%) @ 0/259 sec
07/03 12:20:35 Trace: [squeezebox/client] [10.10.1.9:38938] GOT STAT event_code=STMc crlf_count=0 mas_initialized= mas_mode=0 buffer_size=524280 fullness=0 bytes_received=0 wireless_signal=65535 jiffies=482657934 output_buffer_size=262144 output_buffer_fullness=131072 elapsed_seconds=0 voltage=0 elapsed_milliseconds=0 server_timestamp=0 error_code=0
07/03 12:20:35 Debug: [easyhttp] [10938] POST to http://ws.audioscrobbler.com/2.0/ returned after 58 ms, status code: 200, request body size: 254 B
07/03 12:20:35 Info: [library] saved recent ProfileId=775a5923-67d9-45dd-86b0-fc647e823383 Time=7/3/2023 5:20:35 PM DataType=album Type=long_nav MetadataId=28986489 ContentId=28986489 LibraryId=1202223 Text= Genre=
07/03 12:20:35 Debug: [easyhttp] [10937] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingStart? returned after 407 ms, status code: 201, request body size: 360 B
07/03 12:20:36 Info:
–[ SignalPath ]---------------------------------------------
SignalPath Quality = Lossless
Elements:
Source Format=Flac 44100/24/2 Quality=Lossless
Output OutputType=Squeezebox Quality=Lossless SubType= Model=Kitchen

07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:57}
07/03 12:20:36 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=56 dvc=1 preamp=255 newvol=5632
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:56}
07/03 12:20:36 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=54 dvc=1 preamp=255 newvol=5376
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“zones_changed”:[{“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“display_name”:“Kitchen”,“outputs”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:56,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}],“state”:“playing”,“is_next_allowed”:true,“is_previous_allowed”:true,“is_pause_allowed”:true,“is_play_allowed”:false,“is_seek_allowed”:true,“queue_items_remaining”:13,“queue_time_remaining”:3198,“settings”:{“loop”:“disabled”,“shuffle”:false,“auto_radio”:false},“now_playing”:{“seek_position”:0,“length”:259,“one_line”:{“line1”:“The Same - The Smile”},“two_line”:{“line1”:“The Same”,“line2”:“The Smile”},“three_line”:{“line1”:“The Same”,“line2”:“The Smile”,“line3”:“A Light for Attracting Attention”},“image_key”:“53254906a61a78a8a6c33060265a867e”,“artist_image_keys”:[“fc3ff4ef318cc77ac1aff1be2f500c7d”]}}]}
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“outputs_changed”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:56,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}]}
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] COMPLETE Success
07/03 12:20:36 Trace: [roonapi] [apiclient 10.10.1.9:34506] COMPLETE Success
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:55}
07/03 12:20:37 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=53 dvc=1 preamp=255 newvol=5120
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“zones_changed”:[{“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“display_name”:“Kitchen”,“outputs”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:55,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}],“state”:“playing”,“is_next_allowed”:true,“is_previous_allowed”:true,“is_pause_allowed”:true,“is_play_allowed”:false,“is_seek_allowed”:true,“queue_items_remaining”:13,“queue_time_remaining”:3198,“settings”:{“loop”:“disabled”,“shuffle”:false,“auto_radio”:false},“now_playing”:{“seek_position”:0,“length”:259,“one_line”:{“line1”:“The Same - The Smile”},“two_line”:{“line1”:“The Same”,“line2”:“The Smile”},“three_line”:{“line1”:“The Same”,“line2”:“The Smile”,“line3”:“A Light for Attracting Attention”},“image_key”:“53254906a61a78a8a6c33060265a867e”,“artist_image_keys”:[“fc3ff4ef318cc77ac1aff1be2f500c7d”]}}]}
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“outputs_changed”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:55,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}]}
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] COMPLETE Success
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:54}
07/03 12:20:37 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=51 dvc=1 preamp=255 newvol=4864
07/03 12:20:37 Debug: [prebuffer] sleeping in read – this isn’t good
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“zones_changed”:[{“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“display_name”:“Kitchen”,“outputs”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:54,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}],“state”:“playing”,“is_next_allowed”:true,“is_previous_allowed”:true,“is_pause_allowed”:true,“is_play_allowed”:false,“is_seek_allowed”:true,“queue_items_remaining”:13,“queue_time_remaining”:3198,“settings”:{“loop”:“disabled”,“shuffle”:false,“auto_radio”:false},“now_playing”:{“seek_position”:0,“length”:259,“one_line”:{“line1”:“The Same - The Smile”},“two_line”:{“line1”:“The Same”,“line2”:“The Smile”},“three_line”:{“line1”:“The Same”,“line2”:“The Smile”,“line3”:“A Light for Attracting Attention”},“image_key”:“53254906a61a78a8a6c33060265a867e”,“artist_image_keys”:[“fc3ff4ef318cc77ac1aff1be2f500c7d”]}}]}
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“outputs_changed”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:54,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}]}
07/03 12:20:37 Trace: [roonapi] [apiclient 10.10.1.9:34506] COMPLETE Success
07/03 12:20:38 Trace: [roonapi] [apiclient 10.10.1.9:34506] GOT com.roonlabs.transport:2/change_volume {“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“how”:“absolute”,“value”:53}
07/03 12:20:38 Trace: [squeezebox/client] [10.10.1.9:38938] SENT audg oldvol=50 dvc=1 preamp=255 newvol=4608
07/03 12:20:38 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“zones_changed”:[{“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“display_name”:“Kitchen”,“outputs”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:53,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}],“state”:“playing”,“is_next_allowed”:true,“is_previous_allowed”:true,“is_pause_allowed”:true,“is_play_allowed”:false,“is_seek_allowed”:true,“queue_items_remaining”:13,“queue_time_remaining”:3198,“settings”:{“loop”:“disabled”,“shuffle”:false,“auto_radio”:false},“now_playing”:{“seek_position”:0,“length”:259,“one_line”:{“line1”:“The Same - The Smile”},“two_line”:{“line1”:“The Same”,“line2”:“The Smile”},“three_line”:{“line1”:“The Same”,“line2”:“The Smile”,“line3”:“A Light for Attracting Attention”},“image_key”:“53254906a61a78a8a6c33060265a867e”,“artist_image_keys”:[“fc3ff4ef318cc77ac1aff1be2f500c7d”]}}]}
07/03 12:20:38 Trace: [roonapi] [apiclient 10.10.1.9:34506] CONTINUE Changed {“outputs_changed”:[{“output_id”:“1701d9efc4576dac8082868be073c7bd2932”,“zone_id”:“1601d9efc4576dac8082868be073c7bd2932”,“can_group_with_output_ids”:[“1701c8f4ef268700e0969e24fabf369e2a93”,“170192ebbf453cf8af11944ce9c0a522c6c4”,“17012ab9d34e86efa3969977a002a9d55877”,“1701d9efc4576dac8082868be073c7bd2932”,“1701ac06c76f91e08ec9f72834f8fb16c7ac”,“1701e2e0fd8757491778d99fdbbbb86a71f6”,“1701931a90aef0cf67fdb237b7c1098ea4b7”,“1701254cb4e9a5e1088009f574547063a860”],“display_name”:“Kitchen”,“volume”:{“type”:“number”,“min”:0,“max”:100,“value”:53,“step”:1,“is_muted”:false,“hard_limit_min”:0,“hard_limit_max”:100,“soft_limit”:100},“source_controls”:[{“control_key”:“1”,“display_name”:“Kitchen”,“supports_standby”:true,“status”:“indeterminate”}]}]}
07/03 12:20:38 Trace: [roonapi] [apiclient 10.10.1.9:34506] COMPLETE Success

Hi Monty,

Don’t know if you ever fixed this or just gave up with RHEOS? Sorry its taken some time to find a way to replicate this.

I’ve been able to reproduce this type of behavior when I set “Volume on Play” or “Volume Feedback” to settings other than “Never” in the RHEOS Extension “Advanced Settings”.

If you could take a look at your advanced settings and let me know if this had been changed from the default of “Never” for either of these it would be super helpful.

Remember to restart after you update and save settings (this will be corrected in the next test release)

Best

Peter

Peter, thanks for the update.

I tested again tonight with RHEOS 6.5-17 which exhibited the same behavior.

However, Volume on Play was not set to Never so I changed it to that.

So far so good - seems to be better.

(No idea what that option is supposed to do. I don’t imagine that I ever changed it.)

Here is something else that has to do with the volume display. My volume remains constant, but since I installed Rheos, what you see in the video happens.
Part1

Part2

This happens when I use the unit via RAAT, a raspberry pi and an optical digital input. It happens whether music is playing or not.

Rheos itself does not cause any problems. The phenomenon stops when I stop Rheos in the extension manager, Volume stays at 0dB. Other Roon endpoints are not affected.

EDIT: Sorry for the crappy gifs
Here’s the original video.

Try the latest 0.7.1-0 version - docker latest or update via extension manager.

I think this will solve “creepy volume”. Though was very hard to replicate on my system!

In addition several new features. Watch out for updated readme and posts.

You win the prize for best title for a bug report - keep them coming please.

:trophy:

Peter

Thanks Peter!

I’ll update and test this week once my fiancée isn’t working from home on her “death star” project and demanding silence.

In the meantime, I’ve upgraded my Roon Server from win10 to a Macbook Pro with a clean Ventura install. Looking forward to playing more with that now that the server is fast and clean.

Thanks for the prize!

monty

1 Like

@peter_richardson - having ongoing issues, and Roon support suggested that RHEOS may be responsible for occasional dropouts across all devices including Apple (MacOS, iOS, AppleTV) and Naim. See Roon client fails to show music - on same Win10 machine as core, and iOS and MacOS - #22 by Carl

For now I’ve disabled RHEOS for testing. Happy to email you a log file if helpful. I’m not sure if the crazy log file accumulation was simply caused by a debug mode switch or by an actual problem somewhere… it does look like a crazy amount of traffic related to RHEOS and all my connected zones…

monty

I don’t experience this at all in my many zones only one uses RHEOS others are all mixed RAAT and Chromecasts.

@peter_richardson I’m having trouble posting any meaningful amount of the trace here. See if this Google Drive link works instead:

monty