Roon Core Machine
Roon core on Ubuntu 20.04 headless server.
NUC10, 16gb RAM, i7 CPU
Networking Gear & Setup Details
Ethernet 1gb wired core and clients.
GB broadband, speed on the roon core at the time of error was 630MBs down / 50Mbs (speedtest-cli)
Connected Audio Devices
Ropieee (RPi4) wired , pro-ject digital S2 usb connected.
Number of Tracks in Library
23000 tracks
Description of Issue
I have a song playback skipping after 60-80% playback. The same song skipped twice in 10 minutes. here is the log extract :
11/17 18:17:01 Trace: [Pro-Ject S2] [Lossless 62.4x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:01/3:51] Call Me - Deee-Lite
11/17 18:17:02 Trace: [streamingmediafile] [61] [http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOGVkYTQ3YzhiMzIxNDE3Y2JiMDg2ZDEyZWQyNDhjNjlfNjAubXA0/0.flac] [cachedbytes=0/26027421] killing previous immediate read because 15204352 != 0
11/17 18:17:02 Trace: [streamingmediafile] [61] [http://sp-pr-fa.audio.tidal.com/mediatracks/CAEaKRInOGVkYTQ3YzhiMzIxNDE3Y2JiMDg2ZDEyZWQyNDhjNjlfNjAubXA0/0.flac] [cachedbytes=0/26027421] starting immediate read at off=15204352 length=26027421
11/17 18:17:06 Trace: [Pro-Ject S2] [Lossless 62.2x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:06/3:51] Call Me - Deee-Lite
11/17 18:17:11 Trace: [Pro-Ject S2] [Lossless 62.1x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:11/3:51] Call Me - Deee-Lite
11/17 18:17:15 Info: [stats] 27737mb Virtual, 1424mb Physical, 462mb Managed, 321 Handles, 102 Threads
11/17 18:17:16 Trace: [Pro-Ject S2] [Lossless 62.3x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:16/3:51] Call Me - Deee-Lite
11/17 18:17:17 Trace: [roonapi] [apiclient 192.168.0.69:56888] CONTINUE Changed {"message":"Running (82)","is_error":false}
11/17 18:17:21 Trace: [Pro-Ject S2] [Lossless 62.3x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:21/3:51] Call Me - Deee-Lite
11/17 18:17:26 Trace: [Pro-Ject S2] [Lossless 62.4x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:26/3:51] Call Me - Deee-Lite
11/17 18:17:30 Info: [stats] 27737mb Virtual, 1424mb Physical, 486mb Managed, 321 Handles, 105 Threads
11/17 18:17:30 Trace: [Pro-Ject S2] [zoneplayer/raat] sync Pre Box S2 Digital: realtime=3641135782803 rtt=0us offset=427925782us delta=-210us drift=-1479us in 150.592s (-9.823ppm, -35.364ms/hr)
11/17 18:17:32 Trace: [Pro-Ject S2] [Lossless 62.3x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:32/3:51] Call Me - Deee-Lite
11/17 18:17:37 Trace: [Pro-Ject S2] [Lossless 62.2x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:37/3:51] Call Me - Deee-Lite
11/17 18:17:42 Trace: [Pro-Ject S2] [Lossless 62.1x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [100% buf] [PLAYING @ 2:42/3:51] Call Me - Deee-Lite
11/17 18:17:45 Info: [stats] 27953mb Virtual, 1424mb Physical, 443mb Managed, 321 Handles, 133 Threads
11/17 18:17:47 Trace: [Pro-Ject S2] [Lossless 62.1x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [80% buf] [PLAYING @ 2:47/3:51] Call Me - Deee-Lite
11/17 18:17:52 Trace: [Pro-Ject S2] [Lossless 62.0x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [38% buf] [PLAYING @ 2:52/3:51] Call Me - Deee-Lite
11/17 18:17:57 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:17:57 Trace: [Pro-Ject S2] [Lossless 62.0x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [2% buf] [PLAYING @ 2:57/3:51] Call Me - Deee-Lite
11/17 18:17:57 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:00 Info: [stats] 27977mb Virtual, 1424mb Physical, 459mb Managed, 321 Handles, 132 Threads
11/17 18:18:00 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:01 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:01 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:02 Trace: [Pro-Ject S2] [Lossless 62.0x, 16/44 MQA TIDAL FLAC => 24/44 MQA] [PLAYING @ 3:02/3:51] Call Me - Deee-Lite
11/17 18:18:03 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:03 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":1095,"status":"Dropout"}
11/17 18:18:03 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:04 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:04 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:04 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:05 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:05 Debug: [prebuffer] sleeping in read -- this isn't good
11/17 18:18:05 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:06 Trace: [Pre Box S2 Digital] [raatclient] GOT [41] {"samples":22060,"status":"Dropout"}
11/17 18:18:06 Warn: [Pro-Ject S2] [zoneplayer/raat] Too many dropouts (>3s dropped out in the last 30s). Killing stream
11/17 18:18:06 Trace: [Pro-Ject S2] [zoneplayer/raat] too many dropouts. stopping stream
11/17 18:18:06 Warn: [zone Pro-Ject S2] Track Stopped Due to Slow Media
11/17 18:18:06 Trace: [Pro-Ject S2] [zoneplayer/raat] Endpoint Pre Box S2 Digital State Changed: Playing => Prepared
11/17 18:18:06 Trace: [Pre Box S2 Digital] [raatclient] SENT [43]{"request":"end_stream"}
11/17 18:18:06 Debug: [raat/tcpaudiosource] disconnecting
11/17 18:18:06 Info: [library] recorded play for profile aedb201d-e179-48a7-bbcf-ee176920a45c: mediaid=168:0:3330935 metadataid= contentid=168:0:33309