RoonOnNas failure(s)

Roon Core Machine

Synology DS1821+, AMD Ryzen V1500B, 4GB RAM
Roon Labs LLC, Installer by Christopher Rieke, 2021-03-08 (Synology DSM6)

Networking Gear & Setup Details

Asus RT-AC68U

Connected Audio Devices

Linn Majik DSM
Everything is hardwired through RJ45, plugged directly into the Asus RT-AC68U

Library Size

6k+ tracks

Description of Issue

Roon client software loses audio zone. Restarting the Roon Server on the Synology DS1821+ resolves the issue, but only for a day or so :roll_eyes:

Playback progress on the Roon client software stops updating, although music is playing on the Linn Majik DSM :thinking:

Playback suddenly halts. On the Majik I see the hourglass turning. When I press the power button on the Majik, the screen turns black as if it turns of, but immediately turns on again, and playback resumes :flushed:

The first issue is definitely related to Roon Server running on the Synology DS1821+. The other two issues might be related too, but I’m not sure…
Definitely drives me nuts that I can’t enjoy a single evening without any playback issues.

Either way, I can provide log files and other info if needed. Not sure if I can post them directly, but I could provide a Wetransfer link.

I really hope someone can help me get to the bottom of this :slightly_smiling_face:

Hi @James_Vanderhaeghen

The CPU in this device is definitely below what we’d typically recommend for a Roon Core. It’s hard to say for sure that this is the issue you’re seeing here, but it’s definitely a possibility. Do you have another device that you could temporarily try to run as your Core? Do you experience the same issue?

Hi Dylan,
Thanks for your reply. I just checked the CPU load on the Synology while using Roon. And at Roon startup it goes to 29%. While playing it’s around 6%.
But before I could do that I had to restart the Roon Server on the Synology again. Seems that there is something going wrong with it communicating properly with Roon running on my Macbook Pro. This is from the Roon Server log file before I restarted the Roon Server on the Synology:

08/21 15:52:03 Trace: [raatserver] [Built-in Output] lost client connection. Retrying
08/21 15:52:03 Info: [raatserver] [Built-in Output] connecting (attempt 1)
08/21 15:52:03 Info: [transport] destroyed zone MacBook Pro was playing? False
08/21 15:52:03 Trace: [zone MacBook Pro] Suspend
08/21 15:52:03 Info: [zone MacBook Pro] Canceling Pending Sleep
08/21 15:52:03 Info: [zone MacBook Pro] Canceling Pending Sleep
08/21 15:52:03 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] lost client connection. Retrying
08/21 15:52:03 Warn: [raat_ll/client] [Built-in Output] failed to connect Object reference not set to an instance of an object
08/21 15:52:03 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] connecting (attempt 1)
08/21 15:52:12 Info: [stats] 4767mb Virtual, 409mb Physical, 161mb Managed, 0 Handles, 66 Threads
08/21 15:52:13 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] client connection failed. Retrying in 500ms
08/21 15:52:13 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
08/21 15:52:13 Trace: [push] connecting to 35.237.82.78:9204
08/21 15:52:14 Trace: [push] connected
08/21 15:52:14 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] connecting (attempt 2)
08/21 15:52:24 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] client connection failed. Retrying in 750ms
08/21 15:52:25 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] connecting (attempt 3)
08/21 15:52:27 Info: [stats] 4769mb Virtual, 410mb Physical, 164mb Managed, 0 Handles, 68 Threads
08/21 15:52:35 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] client connection failed. Retrying in 1125ms
08/21 15:52:36 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] connecting (attempt 4)
08/21 15:52:42 Info: [stats] 4770mb Virtual, 411mb Physical, 164mb Managed, 0 Handles, 66 Threads
08/21 15:52:46 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] client connection failed. Retrying in 1687ms
08/21 15:52:47 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] connecting (attempt 5)
08/21 15:52:57 Info: [stats] 4771mb Virtual, 412mb Physical, 165mb Managed, 0 Handles, 66 Threads
08/21 15:52:57 Trace: [raatserver] [RaatServer MacBookPro @ 192.168.1.11:9200] client connection failed. Giving up
08/21 15:52:57 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)

Not sure why this is happening.

And here is an instance where playback stops, and can be resumed by pushig the power button on the Majik… :roll_eyes: :

08/21 17:17:13 Trace: [Majik DSM] [Enhanced 26.6x, 24/44 QOBUZ FLAC => 24/192] [1% buf] [PLAYING @ 4:00/4:00] Other Side of the Wheel - Nadia Reid
08/21 17:17:18 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
08/21 17:17:18 Trace: [push] connecting to 35.196.114.77:9204
08/21 17:17:18 Trace: [push] connected
08/21 17:17:24 Info: [stats] 5028mb Virtual, 829mb Physical, 354mb Managed, 0 Handles, 88 Threads
08/21 17:17:33 Trace: [push] restarting connection (Unable to read data from the transport connection: interrupted.)
08/21 17:17:33 Trace: [push] retrying connection in 56352ms
08/21 17:17:38 Trace: [Majik DSM] [Enhanced 26.6x, 24/44 QOBUZ FLAC => 24/192] [1% buf] [PLAYING @ 4:00/4:00] Other Side of the Wheel - Nadia Reid
08/21 17:17:39 Info: [stats] 5028mb Virtual, 829mb Physical, 354mb Managed, 0 Handles, 86 Threads
08/21 17:17:41 Error: [cast/client] [SHIELD-Android-TV-71b74c059f8aaa4eb9f00fc88d2b3c0f._googlecast._tcp.local] Failed connect to 192.168.1.137 port 8009
08/21 17:17:43 Trace: [Majik DSM] [Enhanced 26.6x, 24/44 QOBUZ FLAC => 24/192] [1% buf] [PLAYING @ 4:00/4:00] Other Side of the Wheel - Nadia Reid
08/21 17:17:44 Trace: Successful POST response from https://push.roonlabs.com/push/1/connect
08/21 17:17:44 Trace: [push] connecting to 35.237.82.78:9204
08/21 17:17:44 Trace: [push] connected
08/21 17:17:52 Info: [songcastdirect] [Linn Majik DSM] [client:192.168.1.56:49967] OnRead(off=0, count=0)
08/21 17:17:52 Info: [songcastdirect] [Linn Majik DSM] LostControl(standby)
08/21 17:17:52 Trace: [songcastdirect] [Linn Majik DSM] lost control of master device: standby
08/21 17:17:52 Trace: [songcastdirect] [Linn Majik DSM] Transition Connected => Idle
08/21 17:17:52 Info: [library] recorded play for profile bf9d5334-4d5a-42a9-bb5c-af57b1666fd9: mediaid=50:1:3c073d7c-49a9-40ee-8a5a-182650c82a1c metadataid= contentid=202:0:112711822 libraryid=50:1:3c073d7c-49a9-40ee-8a5a-182650c82a1c isfromswim=False
*08/21 17:17:52 Info: *
–[ SignalPath ]---------------------------------------------
SignalPath Quality = Enhanced
Elements:

  • Source Format=Flac 44100/24/2 Quality=Lossless*
  • UpgradeBitDepth FromBitsPerSample=24 ToBitsPerSample=64 Quality=Lossless*
  • VolumeNormaliation GainDb=-4.22 Quality=Enhanced*
  • SampleRateConversion FromSampleRate=44100 ToSampleRate=192000 Algorithm=HighQuality Quality=Enhanced*
  • Truncate FromBitsPerSample=64 ToBitsPerSample=24 Quality=Lossless*
  • Output OutputType=SongcastDirect Quality=Lossless SubType= Model=Linn Majik DSM*
    ------------------------------------------------------------
    08/21 17:17:52 Info: [zone Majik DSM] OnPlayFeedback StoppedEndOfMediaNatural
    08/21 17:17:52 Debug: [zone Majik DSM] _Advance
    08/21 17:17:52 Trace: [library] finished with 10 dirty tracks 1 dirty albums 1 dirty performers 10 dirty works 10 dirty performances 0 clumping tracks, 0 clumping auxfiles 0 compute tracks, 0 deleted tracks, 0 tracks to (re)load, 0 tracks to retain, 0 auxfiles to (re)load, 0 auxfiles to retain, and 23 changed objects
    08/21 17:17:52 Info: [audio/env] [zoneplayer] All streams were disposed
    08/21 17:17:52 Trace: [Majik DSM] [Enhanced 8.0x, 24/44 QOBUZ FLAC => 24/192] [1% buf] [PLAYING @ 4:00/4:00] Other Side of the Wheel - Nadia Reid
    08/21 17:17:52 Info: changemedia media= track=
    08/21 17:17:52 Trace: [dbperf] flush 0 bytes, 0 ops in 1 ms (cumulative 809468 bytes, 394 ops in 4368 ms)
    08/21 17:17:52 Trace: [library] endmutation in 39ms
    08/21 17:17:52 Trace: [Majik DSM] [Enhanced 8.0x, 24/44 QOBUZ FLAC => 24/192] [1% buf] [LOADING @ 0:00] Best Thing - Nadia Reid
    08/21 17:17:52 Trace: [dbperf] flush 0 bytes, 0 ops in 3 ms (cumulative 809468 bytes, 394 ops in 4371 ms)
    08/21 17:17:52 Debug: [easyhttp] [163] GET to https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&intent=stream&request_sig=518d9d9c686754422148c91096ccca8c&request_ts=1629559072&track_id=112711823 returned after 257 ms, status code: 200
    08/21 17:17:52 Info: [Majik DSM] [zoneplayer] Playing: https://streaming-qobuz-std.akamaized.net/file
    08/21 17:17:52 Trace: [streamingmediafile] [10] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=0/-1] starting caching…
    08/21 17:17:52 Info: [audio/env] [zoneplayer → stream] All streams were disposed
    08/21 17:17:52 Debug: [easyhttp] [158] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingEnd? returned after 391 ms, status code: 200
    08/21 17:17:52 Trace: [streamingmediafile] [10] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=0/-1] got length 49232718
    08/21 17:17:52 Debug: [easyhttp] [164] GET to https://www.qobuz.com/api.json/0.2/track/getFileUrl?format_id=27&intent=stream&request_sig=42a0f9833c9dc667fbd1b4da53f7e133&request_ts=1629559072&track_id=112711824 returned after 402 ms, status code: 200
    08/21 17:17:52 Info: [Majik DSM] [zoneplayer] Queueing: https://streaming-qobuz-std.akamaized.net/file
    08/21 17:17:52 Trace: [streamingmediafile] [11] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=0/-1] starting caching…
    08/21 17:17:52 Trace: [streamingmediafile] [10] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=524288/49232718] killing previous immediate read because 262144 != 0
    08/21 17:17:52 Trace: [streamingmediafile] [10] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=524288/49232718] starting immediate read at off=262144 length=49232718
    08/21 17:17:52 Debug: [easyhttp] [162] POST to https://metadata.roonlabs.net/1/performers/translate?c=qobuz-be returned after 563 ms, status code: 200
    08/21 17:17:52 Debug: [easyhttp] [160] POST to https://metadata.roonlabs.net/1/performers/translate?c=qobuz-be returned after 645 ms, status code: 200
    08/21 17:17:52 Trace: [streamingmediafile] [11] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=0/-1] got length 43262492
    08/21 17:17:52 Debug: [easyhttp] [159] POST to https://metadata.roonlabs.net/1/albums/translate?c=qobuz-be returned after 673 ms, status code: 200
    08/21 17:17:52 Debug: [easyhttp] [161] POST to https://metadata.roonlabs.net/1/albums/translate?c=qobuz-be returned after 641 ms, status code: 200
    08/21 17:17:52 Info: [Majik DSM] [zoneplayer] Open Result (Playing):Result[Status=Success]
    08/21 17:17:52 Info: [Majik DSM] [zoneplayer] Starting playback
    08/21 17:17:52 Trace: [prebuffer] ready 149940/441000 (34%) @ 0/250 sec
    08/21 17:17:52 Trace: [songcastdirect] [Linn Majik DSM] Transition Idle => AwaitingConnection
    08/21 17:17:52 Trace: [streamingmediafile] [11] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=262144/43262492] killing previous immediate read because 262144 != 0
    08/21 17:17:52 Trace: [streamingmediafile] [11] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=262144/43262492] starting immediate read at off=262144 length=43262492
    08/21 17:17:53 Trace: [songcastdirect] [Linn Majik DSM] got Scd client 192.168.1.56:51503
    08/21 17:17:53 Trace: [songcastdirect] [Linn Majik DSM] Transition AwaitingConnection => Connected
    08/21 17:17:53 Info: [songcastdirect] [Linn Majik DSM] [client:192.168.1.56:51503] OnRead(off=0, count=15)
    08/21 17:17:53 Info: buffering media is lossless Flac => True
    *08/21 17:17:53 Info: *
    –[ SignalPath ]---------------------------------------------
    SignalPath Quality = Enhanced
    Elements:
  • Source Format=Flac 44100/24/2 Quality=Lossless*
  • UpgradeBitDepth FromBitsPerSample=24 ToBitsPerSample=64 Quality=Lossless*
  • VolumeNormaliation GainDb=-4.22 Quality=Enhanced*
  • SampleRateConversion FromSampleRate=44100 ToSampleRate=192000 Algorithm=HighQuality Quality=Enhanced*
  • Truncate FromBitsPerSample=64 ToBitsPerSample=24 Quality=Lossless*
  • Output OutputType=SongcastDirect Quality=Lossless SubType= Model=Linn Majik DSM*
    ------------------------------------------------------------
    08/21 17:17:53 Info: [Majik DSM] [zoneplayer] Open result (Queueing): Result[Status=Success]
    08/21 17:17:53 Info: [zone Majik DSM] OnPlayFeedback Playing
    08/21 17:17:53 Trace: [Majik DSM] [Enhanced, 24/44 QOBUZ FLAC => 24/192] [100% buf] [PLAYING @ 0:00] Best Thing - Nadia Reid
    08/21 17:17:53 Debug: [easyhttp] [165] POST to https://www.qobuz.com/api.json/0.2/track/reportStreamingStart? returned after 66 ms, status code: 201
    *08/21 17:17:53 Info: *
    –[ SignalPath ]---------------------------------------------
    SignalPath Quality = Enhanced
    Elements:
  • Source Format=Flac 44100/24/2 Quality=Lossless*
  • UpgradeBitDepth FromBitsPerSample=24 ToBitsPerSample=64 Quality=Lossless*
  • VolumeNormaliation GainDb=-4.22 Quality=Enhanced*
  • SampleRateConversion FromSampleRate=44100 ToSampleRate=192000 Algorithm=HighQuality Quality=Enhanced*
  • Truncate FromBitsPerSample=64 ToBitsPerSample=24 Quality=Lossless*
  • Output OutputType=SongcastDirect Quality=Lossless SubType= Model=Linn Majik DSM*
    ------------------------------------------------------------
    08/21 17:17:54 Info: [stats] 4969mb Virtual, 772mb Physical, 252mb Managed, 0 Handles, 99 Threads
    08/21 17:17:55 Trace: [streamingmediafile] [10] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=49232718/49232718] finished caching
    08/21 17:17:56 Warn: [songcastdirect] [Linn Majik DSM] time discontinuity. Expected 0, Got 2
    08/21 17:17:56 Warn: [songcastdirect] [Linn Majik DSM] time discontinuity. Expected 1, Got 2
    08/21 17:17:58 Trace: [streamingmediafile] [11] [https://streaming-qobuz-std.akamaized.net/file] [cachedbytes=43262492/43262492] finished caching

Funnily enough I get a similar issue with Roon Bridge restarting every 86 minutes or so on a Raspberry Pi.
Doesn’t matter what OS is on the Pi (used Moode Audio, RaspiOS and Ropieee) nor does it matter if the Pi is connected to the network via Wi-Fi or Ethernet.

The Roon Server running on my Ubuntu server is fine, all other non-RAAT endpoints are fine and will continue playing while Roon Bridge on the Pi just restarts mid-play with journal messages as below.
Can also output to the same Pi via Airplay (using Moode Audio) and no interruptions.

I’ve started a new thread here on my issue but this thread might actually be the same problem.
It think it might be relevant that I also have an Asus AC68U router.

Hi @James_Vanderhaeghen,

Please note the exact local time + date when this issue next occurs and the name of the track that was playing and upload your Roon Logs by using these instructions. The best way to get them over to me would be via Dropbox / Google Drive, but if you don’t have either service please let me know and I can provide alternate upload instructions.

Hi @dylan ,

24 August 2021 around 21:38, Ane Brun - Meet you at the delta
there was a brief interruption during playback. I closed my MacBook Pro minutes before that. When opening and switching to Roon the progress bar was not moving , the song still on the previous one. It then jumped to the current song, but remained stuck on 6 seconds into it. Music keeps playing. Closing my Macbook again.

24 August 2021 around 21:45, Ane Brun - Trust
Almost at the end of the song the music stops. The Linn Majik has the hour clock turning, waiting for something. I push the power button on the Linn. Linn goes to standby and immediately turns on. Playback resumes. I think it resumed from the beginning of the song. Hard to tell cause Roon progress bar is now stuck on 0 seconds into this track. Closing my Macbook again.

24 August 2021 around 21:55 Ane Brun - Gentle Wind of Gratitude
Exact same thing as around 21:45. This time I’m sure it starts from the top. Roon is suddenly in sync with playback again.

I’ve sent a Wetransfer to myself. This is the link I got and what is contained in it:

Download link

2 items
RAATServer Logs.zip
35.7 KB
RoonServer Logs.zip
2.81 MB

Let me know if that works for you :smiley:

@Vin ,

My Synology and Linn Majik already had static IP’s (configured on the Asus RT-AC68U). I gave my Macbook a static IP too. Didn’t affect anything in my case…

Thanks, @James_Vanderhaeghen — Logs received, we’ll take a look. Something I’m hoping you can confirm (I didn’t see for sure when reviewing our previous communications) — Is this only happening with the Linn? If you play to System Output of the MacBook do you see any similar issues? We’re taking a look either way, but knowing this piece of context will help us understand how to better approach this. Thanks!

Hi @dylan ,
I almost never use the System Output of the Macbook when using Roon.
Just did a test with the same album to verify. No problems whatsoever.
It’s pretty sure it only happens with the Linn.

Thanks, @James_Vanderhaeghen. We are currently working on some improvements for Linn devices that we think will help here. I don’t have any specific timelines I can provide, but we think this should be improved with those coming changes.