Error in latest builds - unresponsive control point

I have encountered this problem several times during the part two weeks: when trying to skip to next track or to a different album there is no response. The scrollbar for the tracks duration oscillates left to right. A restart of the Roon core fixes the problem… until it happens again!

System details: 1.7 537 on Antipodes EX. Control point is iPhone 7 running 1.7 537 build

Log entries in case it helps:

04/27 23:44:27 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49554] client connection failed. Retrying in 1125ms 
04/27 23:44:28 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49554] connecting (attempt 4) 
04/27 23:44:28 Warn: [rnet/RnetJsonClient] failed to connect Connection refused 
04/27 23:44:28 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49554] client connection failed. Retrying in 1687ms 
04/27 23:44:29 Info: [stats] 3493mb Virtual, 1099mb Physical, 430mb Managed, 0 Handles, 110 Threads 
04/27 23:44:29 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49554] connecting (attempt 5)

Hi @DrPo,

What kind of zone are you playing to - what is the DAC model/manufacturer?
Does this same behavior happen on multiple zones?

A post was split to a new topic: Auralic Femto - Unresponsive until reboot

hi Norris, did not try this, but what dawned on me is that yesterday morning the iPhone was on 528 build, do it may be that as with my core this behaviour is related to the control point upgrading …

it would be good to have been able to deduce from the logs…

at any rate, zone is MSB Discreet DAC via USB

Hi @DrPo,

You’re saying you only noticed the issue when the Roon app on the iPhone was upgrading from 528 -> 537? The app is now stable and working as expected?

I suspect so. Will carefully monitor tonight (stable build 537)

1 Like

Hi Norris - unfortunately the problem persists

Logs:

21:45:01 Trace: [MSB ProUSB] [Lossless, 24/96 QOBUZ FLAC => 24/96] [17% buf] [LOADING @ 0:00] String Quartet No. 8 in E Major, Op. 80: Andante con moto - Albion Quartet / Antonin Dvorák 
04/28 21:45:01 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49817] connected 
04/28 21:45:01 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"} 
04/28 21:45:01 Trace: [broker/images] update imageid=3419 from url=roon://artists/7a004d4e30303030383531383937/image/__ROON_IMAGE_SIZE__.jpg => Success in 679ms 
04/28 21:45:02 Trace: [broker/images] update imageid=3675 from url=roon://artists/7a004d4e30303030373836323435/image/__ROON_IMAGE_SIZE__.jpg => Success in 277ms 
04/28 21:45:02 Trace: [broker/images] update imageid=3931 from url=roon://artists/5e01c42ec0bebe34db439be1006606174fd2/image/__ROON_IMAGE_SIZE__.jpg => Success in 500ms 
04/28 21:45:02 Trace: [broker/images] update imageid=4187 from url=roon://artists/7a004d4e30303030373833353537/image/__ROON_IMAGE_SIZE__.jpg => Success in 113ms 
04/28 21:45:02 Trace: [broker/images] update imageid=4443 from url=roon://artists/7a004d4e30303030373533353831/image/__ROON_IMAGE_SIZE__.jpg => Success in 120ms 
04/28 21:45:03 Trace: [broker/images] update imageid=4699 from url=roon://artists/7a004d4e30303030363239333330/image/__ROON_IMAGE_SIZE__.jpg => Success in 355ms 
04/28 21:45:03 Trace: [broker/images] update imageid=5467 from url=roon://artists/7a004d4e30303030393433323638/image/__ROON_IMAGE_SIZE__.jpg => Success in 386ms 
04/28 21:45:03 Trace: [broker/images] update imageid=5723 from url=roon://artists/7a004d4e30303032323330393335/image/__ROON_IMAGE_SIZE__.jpg => Success in 115ms 
04/28 21:45:03 Trace: [broker/images] update imageid=6235 from url=roon://artists/7a004d4e30303030323437303737/image/__ROON_IMAGE_SIZE__.jpg => Success in 111ms 
04/28 21:45:04 Trace: [broker/images] update imageid=6491 from url=roon://albums/79004d5730303031343235303437/cover/__ROON_IMAGE_SIZE__.jpg => Success in 699ms 
04/28 21:45:05 Trace: [broker/images] update imageid=7003 from url=roon://artists/5e01c054f771d1f2544a8d70cc0ee409ca00/image/__ROON_IMAGE_SIZE__.jpg => Success in 610ms 
04/28 21:45:06 Trace: [broker/images] update imageid=7259 from url=roon://albums/79004d5730303031383338343437/cover/__ROON_IMAGE_SIZE__.jpg => Success in 1177ms 
04/28 21:45:07 Info: [stats] 3407mb Virtual, 1189mb Physical, 441mb Managed, 0 Handles, 87 Threads 
04/28 21:45:07 Trace: [broker/images] update imageid=7515 from url=roon://artists/5e01e3d3bf3c9b6d274384ba42cf646c98f9/image/__ROON_IMAGE_SIZE__.jpg => Success in 605ms 
04/28 21:45:07 Trace: [broker/images] update imageid=7771 from url=roon://artists/5e01c12ff16ef440ea41ac52f487840255bd/image/__ROON_IMAGE_SIZE__.jpg => Success in 116ms 
04/28 21:45:07 Trace: [broker/images] update imageid=8027 from url=roon://artists/5e01334a093a600b4848a52559c8ca3763ca/image/__ROON_IMAGE_SIZE__.jpg => Success in 94ms 
04/28 21:45:07 Trace: [broker/images] update imageid=8283 from url=roon://artists/7a004d4e30303030303831313934/image/__ROON_IMAGE_SIZE__.jpg => Success in 630ms 
04/28 21:45:08 Trace: [broker/images] update imageid=8539 from url=roon://artists/7a004d4e30303030333636313634/image/__ROON_IMAGE_SIZE__.jpg => Success in 471ms 
04/28 21:45:08 Trace: [broker/images] update imageid=8795 from url=roon://artists/7a004d4e30303030333035343638/image/__ROON_IMAGE_SIZE__.jpg => Success in 249ms 
04/28 21:45:08 Trace: [broker/images] update imageid=9051 from url=roon://artists/7a004d4e30303031323532323335/image/__ROON_IMAGE_SIZE__.jpg => Success in 264ms 
04/28 21:45:10 Trace: [broker/images] update imageid=9307 from url=roon://albums/79004d5730303031343039313331/cover/__ROON_IMAGE_SIZE__.jpg => Success in 1219ms 
04/28 21:45:11 Trace: [broker/images] update imageid=9563 from url=roon://albums/79004d5230303033343633313737/cover/__ROON_IMAGE_SIZE__.jpg => Success in 1259ms 
04/28 21:45:11 Trace: [broker/images] update imageid=9819 from url=roon://artists/7a004d4e30303031383638383432/image/__ROON_IMAGE_SIZE__.jpg => Success in 82ms 
04/28 21:45:11 Trace: [rnet/RnetJsonClient] no data received for >10000ms. Killing connection. 
04/28 21:45:11 Warn: [rnet/RnetJsonClient] error writing to connection 
04/28 21:45:11 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49817] lost client connection. Retrying 
04/28 21:45:11 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49817] connecting (attempt 1) 
04/28 21:45:11 Trace: [MSB ProUSB] [Lossless, 24/96 QOBUZ FLAC => 24/96] [17% buf] [LOADING @ 0:00] String Quartet No. 8 in E Major, Op. 80: Andante con moto - Albion Quartet / Antonin Dvorák 
04/28 21:45:11 Trace: [raatserver] [RaatServer I019740s-iPhone @ 192.168.1.7:49817] connected 
04/28 21:45:11 Trace: [rnet/RnetJsonClient] SENT {"request":"enumerate_devices","subscription_id":"0"} 
04/28 21:45:12 Trace: [broker/images] update imageid=10075 from url=roon://albums/79004d5730303033333230303532/cover/__ROON_IMAGE_SIZE__.jpg => Success in 1360ms 
04/28 21:45:13 Trace: [broker/images] update imageid=10331 from url=roon://albums/c80034303232313433323334343134/cover/__ROON_IMAGE_SIZE__.jpg => Success in 474ms 
04/28 21:45:13 Trace: [broker/images] update imageid=92 from url=roon://artists/5e013d3e40db5347d6458fcb94db03e882e1/image/__ROON_IMAGE_SIZE__.jpg => Success in 93ms 
04/28 21:45:13 Trace: [broker/images] update imageid=348 from url=roon://artists/7a004d4e30303030323535343934/image/__ROON_IMAGE_SIZE__.jpg => Success in 144ms 
04/28 21:45:13 Trace: [broker/images] update imageid=604 from url=roon://artists/7a004d4e30303030313837333336/image/__ROON_IMAGE_SIZE__.jpg => Success in 132ms 
04/28 21:45:13 Trace: [broker/images] update imageid=860 from url=roon://artists/7a004d4e30303030303131373037/image/__ROON_IMAGE_SIZE__.jpg => Success in 150ms 
04/28 21:45:14 Trace: [broker/images] update imageid=1116 from url=roon://albums/a600333034383338/cover/__ROON_IMAGE_SIZE__.jpg => Success in 369ms 
04/28 21:45:14 Trace: [broker/images] update imageid=1372 from url=roon://artists/7a004d4e30303030353736383339/image/__ROON_IMAGE_SIZE__.jpg => Success in 250ms

Hi @DrPo,

It looks like there is an issue with buffering the stream according to the log snippet. If you try sending the audio stream to your iPhone’s internal speakers, does that play back as expected?

I have to re-encounter the problem then will do so. It does not happen all the time.

1 Like

Hi Norris I tried to switch zones when the problem occurs.

The other zones play OK but resume from their last track, not the one I try to play.

I did a test and temporarily disabling the MSB USB zone allows to play to that zone albeit at the cost of killing the current queue.

This must be a bug with the latest build…

Hi @DrPo,

Thanks for confirming that the other zone worked as expected when this issue occurred on the MSB. This sounds like the issue could be specific to the MSB, since the other zones are still operational and the MSB is in a “bad” state.

Can you confirm you have the latest firmware installed on your MSB? If instead of restarting the Core, you unplug and re-plug in your MSB, does that resolve the issue when it occurs?

Sorry Norris but blaming the USB DAC for that behaviour seems bit forced as a conclusion… what is true is that when this happens toggling between zones seems to solve it (no unplugging / restart required) albeit at the cost of having to select again the track. Please keep an eye for similar input from other users as I am sure it’s not DAC related (it started happening with the last two builds)

Hi @DrPo,

Each zone has it’s own individual queue, and what I believe is happening here is that just the MSB is affected by this issue unless you are saying otherwise and I’m misunderstanding you here.

So to clarify this phrase, you are saying that when this issue occurs on the MSB, you can switch to the iPhone zone, start playback there, then switch back to the MSB zone and then it works again, is that correct?

Hi Norris, so far indeed what I described is the case. I have also noticed that by toggling zones playback resumes from a different track (so indeed buffers seem to be independent).

The only way to assess whether the specific DAC is responsible is to observe the same behavior in a different zone and verify that by toggling to the MSB again solves the issue.

Hi @DrPo,

Yes, can you please confirm this? If you use the previous test I mentioned, that should help clarify:

Hi Norris yes that’s right

Hi @DrPo,

You mentioned “yes, that’s right”, but I don’t understand what this means. Were you able to successfully start playback to the MSB zone by switching to the iPhone zone and then back to the MSB? Could you please let me know the exact local time + date you were able to do this if so?

Hi Noris, I have not come back to you as (for some reason) I have not encountered the problem during the last few weeks. Hope Merphy’s law won’t kick in with this issue occurring immediately after I post this :slight_smile:

1 Like

Hi @DrPo,

That’s fantastic news, do let me know if the system continues to remain stable!

Hi Norris, just for the record. I had the same issue today. By now I know that I have to go into the Roon Core web management page and restart Roon Server to overcome it