Playback stops and RAATServer logs says dropouts[RESOLVED]

Hi,

I’m experiencing this same behaviour on two different computers now, so I thought I’d ask what is up. Playback suddenly stops, and RAATServer logs like this:

11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8020805 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8021687 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8022569 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8023451 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8024333 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8025215 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8026097 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8026979 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8027861 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8028743 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8029625 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8030507 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8031389 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8032271 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8033153 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8034035 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8034917 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8035799 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8036681 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8037563 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8038445 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8039327 [2]
11/23 15:55:15 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [lua@0x7fbb6c001948] [127.0.0.1:35630]  SENT [13] {"samples":22050,"status":"Dropout"}
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8040209 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8041091 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8041973 [2]
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8042855 [2]
11/23 15:55:15 Warn: [jsonserver] client timed out after 10015ms (timeout=10000)
11/23 15:55:15 Trace: [jsonserver] [127.0.0.1:50716] destroying client
11/23 15:55:15 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8043737 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8044619 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8045501 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8046383 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8047265 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8048147 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8049029 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8049911 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8050793 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 882 samples at 8051675 [2]
11/23 15:55:16 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] [server] client timed out after 10004ms (timeout=10000)
11/23 15:55:16 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [server] [127.0.0.1:35630] destroying client
11/23 15:55:16 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [session] [127.0.0.1:35630] destroying session
11/23 15:55:16 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [lua@0x7fbb6c001948] [127.0.0.1:35630]  SENT [13] {"status":"Ended"}
11/23 15:55:16 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [alsa] teardown

I'm running the latest 1.3-276 build of Roon Server on Linux.
The machine the logs are from, is an Intel Atom 520 running Ubuntu 16.04.3
I've also tried an AMD E350 running Ubuntu 17.10.

The DAC is a NAIM Dac-v1 connected via USB. Is this message indicative of something that is off between the computer and the DAC?

Linux keeps saying:
[ 1920.295795] usb 1-3: 2:1: cannot get freq at ep 0x5
[ 1920.299303] usb 1-3: 2:1: cannot get freq at ep 0x5

Happens very regularly, after playing for 5-10 minutes.

Here’s another example.

Roon Server says:

11/23 17:04:46 Trace: [Naim] [Lossless, 24/96 FLAC => 24/96] [5% buf] [PLAYING @ 3:08/3:10] Don't Smoke in Bed - Nina Simone / Willard Robison
11/23 17:04:48 Info: 
--[ SignalPath ]---------------------------------------------
SignalPath Quality = Lossless
Elements:
    Source Format=Flac 96000/24/2 BitRate=2893 Quality=Lossless
    Raat Device=Naim DAC-V1. Audiophilleo.com
    Output OutputType=Local_Alsa Quality=Lossless
------------------------------------------------------------
11/23 17:04:48 Info: [library] recorded play for profile 63fe98eb-bb4d-4360-a016-8c3b0fad16be: mediaid=50:1:f03615b4-49d5-4781-adb9-82981772b621 metadataid=97:0:3346486302281 contentid= libraryid=50:1:f03615b4-49d5-4781-adb9-82981772b621
11/23 17:04:48 Trace: [library] finished with 88 dirty tracks 7 dirty albums 56 dirty performers 45 dirty works 56 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 163 changed objects
11/23 17:04:48 Debug: [library/index] updating search indices: 10 ops 0 adds, 0 removes
11/23 17:04:48 Trace: [dbperf] flush 0 bytes, 0 ops in 42 ms (cumulative 41374009 bytes, 55187 ops in 80151 ms)
11/23 17:04:48 Trace: [library] endmutation in 291ms
11/23 17:04:48 Trace: [analysis] prioritizing next track LibraryTrack[4232754, Nina Simone - Little Girl Blue - Little Girl Blue IsAvailable=True IsDeleted=False ] for zone 22:1:8886f399-a778-de0e-6635-b91ab915716a
11/23 17:04:48 Info: [Naim] [zoneplayer] Queueing: /mnt/RoonStorage_05f73417d466d5c8e2b3021ff6aa2a13e0d1ac65/flac/Little Girl Blue (BCP6028 FLAC 24-bit)/04 - Little Girl Blue.flac
11/23 17:04:48 Trace: [analysis] analyzing (high priority) trackid=4232754 url=/mnt/RoonStorage_05f73417d466d5c8e2b3021ff6aa2a13e0d1ac65/flac/Little Girl Blue (BCP6028 FLAC 24-bit)/04 - Little Girl Blue.flac
11/23 17:04:48 Info: [Naim] [zoneplayer] Open result (Queueing): Result[Status=Success]
11/23 17:04:48 Trace: [prebuffer] ready 326400/960000 (34%) @ 0/257 sec
11/23 17:04:51 Trace: [Naim] [Lossless, 24/96 FLAC => 24/96] [100% buf] [PLAYING @ 0:03/2:29] He Needs Me - Nina Simone / Mark VII / Arthur Hamilton

RAAT server says:

11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1065 samples at 19240000 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19241065 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19242985 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19244905 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19246825 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19248745 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19250665 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19252585 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19254505 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19256425 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19258345 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19260265 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19262185 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19264105 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19266025 [2]
11/23 17:04:58 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19267945 [2]
11/23 17:04:58 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [lua@0x7fbb7c0069a8] [127.0.0.1:50376]  SENT [7] {"status":"Dropout","samples":29865}
... and so on until...
11/23 17:05:01 Warn: [jsonserver] client timed out after 10010ms (timeout=10000)
11/23 17:05:01 Trace: [jsonserver] [127.0.0.1:50952] destroying client
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19567465 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19569385 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19571305 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19573225 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19575145 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19577065 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19578985 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19580905 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19582825 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19584745 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19586665 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19588585 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19590505 [2]
11/23 17:05:01 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19592425 [2]
11/23 17:05:02 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19594345 [2]
11/23 17:05:02 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19596265 [2]
11/23 17:05:02 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] dropout of 1920 samples at 19598185 [2]
11/23 17:05:02 Warn: [RAAT::Naim DAC-V1. Audiophilleo.com] [server] client timed out after 10010ms (timeout=10000)
11/23 17:05:02 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [server] [127.0.0.1:50376] destroying client
11/23 17:05:02 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [session] [127.0.0.1:50376] destroying session
11/23 17:05:02 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [lua@0x7fbb7c0069a8] [127.0.0.1:50376]  SENT [7] {"status":"Ended"}
11/23 17:05:02 Trace: [RAAT::Naim DAC-V1. Audiophilleo.com] [alsa] teardown

Hi, @Adam_Skogman, thanks for the report! Could you please describe your whole setup (Core, Storage, Network Topology)? Because the problem you wrote about can be be caused by different things. So, to narrow down the area of our research, we need more information from you.

Thanks!


Ivan

Absolutely :slight_smile:

My flac files are on a NAS (Asustor), connected via gigabit ethernet.
Both RoonServer and the RAAT endpoint is on the same linux machine (installed using the easy install server script).

Since I had just moved the roon library onto the machine (in both cases), the audio analyzer was running. In fact, since I saw it in the logs just when the system was trying to pre-buffer the next song, I turned analyze-on-demand off. That actually helped. My assumption is, the NAS is slow in delivering the file, so while waiting for auto-analysis, the whole chain times out ( there’s a 10 second timeout).

Ideally, the server should stream first, and not get hung up on analysis. Or pause the player. The fact that the player times out, on repeated dropped samples, then resets, is a not ideal, since the music shouldn’t stop :slight_smile:

Glad to hear that you’re fixed by now, @Adam_Skogman ! I might suggest a workaround here – turning Audio Analysis’s max speed during the night, when you don’t use Roon, and most of your library will be analyzed during this time. Actually, Analysis is the procedure that takes place only once, so in the future you won’t be experiencing this behavior, and there will be no need for Roon to use analyze-on-demand option.

Thanks for your patience and sorry for the inconveniences here!


Ivan

Can you open a ticket with engineering though - this should be handled more gracefully in the code :slight_smile:

Hey Adam,

We can take a look at this, but background analysis is designed to be pretty aggressive, as a number of features (like volume leveling and waveform display) depend on it, and the goal is to get the collection analyzed as quickly as possible.

I agree that this shouldn’t be causing dropouts, but when we hear about dropouts during the initial analysis it’s usually because people are running their Core on an underpowered system. Assuming your Core is running on a device that meets our recommendations, I would be more inclined to think this is related to your storage configuration, or the network connectivity between your Core and your NAS.

Anyway, we’ll discuss – thanks again for the feedback Adam!

This topic was automatically closed after 2 days. New replies are no longer allowed.