I’ve been facing this error message lately more and more. Music drops out or stutters first, then drops and next track starts playing. I’ve noticed it’s always connected to the usage of my storage drive. For example if I open Steam while playing music through Roon, I might soon get this error when Steam accesses the storage drive. I can’t understand why Roon can’t buffer the tracks so that when I access the storage drive while music is playing, it actually wouldn’t matter. Haven’t experienced similar behavior with any other media player applications.
I have RoonServer installed on my computer and I control it separately with Roon app on the same PC, iPad and iPhone. Computer is only few months old with proper specs, i5 8400, 16gb DDR4, SSD system drive, Windows 10 and storage drive is 4TB HDD (Western Digital Blue). Computer is connected through USB cable to Mutec MC-3+ USB.
Here’s what log file says when the dropout happens (RoonServer log).
01/14 14:31:10 Info: [stats] 5811mb Virtual, 29mb Physical, 313mb Managed, 1516 Handles, 75 Threads
01/14 14:31:15 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [13% buf] [PLAYING @ 5:18/6:29] Slush - Hot Chip
01/14 14:31:20 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [19% buf] [PLAYING @ 5:23/6:29] Slush - Hot Chip
01/14 14:31:20 Trace: [Tykki WASAPI] [zoneplayer/raat] sync MC-3+ Smart Clock USB: realtime=1834061096000 rtt=0us offset=-289435904us delta=-32us drift=-23192us in 1834,052s (-12,645ppm, -45,523ms/hr)
01/14 14:31:22 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:24 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:25 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [7% buf] [PLAYING @ 5:28/6:29] Slush - Hot Chip
01/14 14:31:25 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:25 Info: [stats] 5827mb Virtual, 30mb Physical, 313mb Managed, 1532 Handles, 79 Threads
01/14 14:31:25 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:25 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:26 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:26 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:26 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:27 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:28 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:28 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:29 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:30 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:30 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [1% buf] [PLAYING @ 5:33/6:29] Slush - Hot Chip
01/14 14:31:30 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:30 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:30 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:31 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:31 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:31 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:32 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:32 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:33 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:33 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:33 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:34 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:34 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:34 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:34 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:35 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:35 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:35 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [1% buf] [PLAYING @ 5:38/6:29] Slush - Hot Chip
01/14 14:31:35 Trace: [push] restarting connection (Unable to read data from the transport connection: A blocking operation was interrupted by a call to WSACancelBlockingCall.)
01/14 14:31:35 Trace: [push] retrying connection in 56440ms
01/14 14:31:35 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:36 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:36 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:36 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:36 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:36 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:37 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:37 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:37 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:38 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:38 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:38 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:38 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:38 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:39 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:39 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:39 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:40 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:40 Trace: [Tykki WASAPI] [Lossless, 16/44 FLAC => 16/44] [1% buf] [PLAYING @ 5:43/6:29] Slush - Hot Chip
01/14 14:31:40 Info: [stats] 5811mb Virtual, 31mb Physical, 312mb Managed, 1520 Handles, 75 Threads
01/14 14:31:40 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:40 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:40 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":4833}
01/14 14:31:41 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:41 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":20703}
01/14 14:31:41 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:41 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:41 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":22050}
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":17640}
01/14 14:31:42 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:42 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":11853}
01/14 14:31:43 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":22050}
01/14 14:31:43 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:43 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:43 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":22050}
01/14 14:31:44 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:44 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:44 Debug: [prebuffer] sleeping in read -- this isn't good
01/14 14:31:44 Trace: [MC-3+ Smart Clock USB] [raatclient] GOT [7] {"status":"Dropout","samples":22050}
01/14 14:31:44 Warn: [Tykki WASAPI] [zoneplayer/raat] Too many dropouts (>3s dropped out in the last 30s). Killing stream
01/14 14:31:44 Trace: [Tykki WASAPI] [zoneplayer/raat] too many dropouts. stopping stream
01/14 14:31:44 Info: [Tykki WASAPI] [zoneplayer] advance didn't change the track. returning short read
01/14 14:31:44 Warn: Track Stopped Due to Slow Media
01/14 14:31:44 Info: [audio/env] [zoneplayer -> stream] All streams were disposed
01/14 14:31:44 Debug: Lastfm 'f2271328bfd37e591fd543d69d8654c4' DONE: Hot Chip - Slush
01/14 14:31:44 Info: [zone Tykki WASAPI] OnPlayFeedback StoppedEndOfMediaUnnatural
01/14 14:31:44 Debug: [zone Tykki WASAPI] _Advance
01/14 14:31:44 Info: [audio/env] [zoneplayer] All streams were disposed
01/14 14:31:44 Info: [audio/env] [zoneplayer -> stream -> endpoint] All streams were disposed
What does sleeping in read mean? I’ve configured the PC with high performance power saving settings and HDD shouldn’t sleep until it’s been idling for 120 minutes.
Any advice how to get rid of the problem? Thanks in advance.