Live Radio Stops with No Feedback on Controller. Log might have the answer

Support
1

Core Machine (Operating system/System info/Roon build number)
Rock on NUC

Network Details (Including networking gear model/manufacturer and if on WiFi/Ethernet)

Ethernet

Audio Devices (Specify what device you’re using and its connection type - USB/HDMI/etc.)

Raspberry Pi with HiFiBerry DAC+ HAT running Ropieee controlled by Samsung Android tablet.

Description Of Issue

This occurred during Live Radio playback from www.classicalfm.ca.

Occasionally playback stops for no apparent reason as evidenced on the controller. But the log excerpt below was captured just after one such event. I think things went south at 04:07:28.

Why doesn’t playback simply offer stuttering playback and let me decide when something’s going wrong?
Who gets to decide that >3s dropped out in the last 30s is too many dropouts?
And write “Killing stream” into the log with nary a peep on the controller?

LOG EXCERPT

10/28 04:07:24 Trace: [Bedroom] [LowQuality, 24/44 MP3 => 24/44] [100% buf] [PLAYING @ 74:04] ROBERT SCHUMANN (1810-1856) GER - KINDERSCENEN: TRAUMEREI (DREAMING)
10/28 04:07:26 Info: [stats] 25595mb Virtual, 3157mb Physical, 612mb Managed, 305 Handles, 81 Threads
10/28 04:07:28 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:20686}
10/28 04:07:29 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:29 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:30 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:30 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:31 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:31 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Dropout”,“samples”:22050}
10/28 04:07:31 Warn: [Bedroom] [zoneplayer/raat] Too many dropouts (>3s dropped out in the last 30s). Killing stream
10/28 04:07:31 Trace: [Bedroom] [zoneplayer/raat] too many dropouts. stopping stream
10/28 04:07:31 Trace: [Bedroom] [LowQuality, 24/44 MP3 => 24/44] [100% buf] [PLAYING @ 74:07] ROBERT SCHUMANN (1810-1856) GER - KINDERSCENEN: TRAUMEREI (DREAMING)
10/28 04:07:31 Trace: [Bedroom] [zoneplayer/raat] Endpoint snd_rpi_hifiberry_dacplus State Changed: Playing => Prepared
10/28 04:07:31 Warn: [zone Bedroom] Track Stopped Due to Slow Media
10/28 04:07:31 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] SENT [164]{“request”:“end_stream”}
10/28 04:07:31 Trace: Attempting to play channel URL: icy://prod-35-199-150-166.wostreaming.net/mzmedia-cfmzfmmp3-ibc2?session-id=0ff4b13e5d5989401f235959bbc6325f&source=TuneIn
10/28 04:07:31 Debug: [raat/tcpaudiosource] disconnecting
10/28 04:07:31 Info: [zone Bedroom] OnPlayFeedback StoppedEndOfMediaUnnatural
10/28 04:07:31 Info: [Bedroom] [zoneplayer] advance didn’t change the track. returning short read
10/28 04:07:31 Info: [audio/env] [zoneplayer -> stream] All streams were disposed
10/28 04:07:31 Info: [zone Bedroom] OnPlayFeedback Stopped
10/28 04:07:31 Info: [audio/env] [zoneplayer -> stream -> endpoint] All streams were disposed
10/28 04:07:31 Info: [zone Bedroom] Canceling Pending Sleep
10/28 04:07:31 Info: [zone Bedroom] Canceling Pending Sleep
10/28 04:07:31 Trace: [Bedroom] [LowQuality, 24/44 MP3 => 24/44] [100% buf] [STOPPED @ 0:00] ROBERT SCHUMANN (1810-1856) GER - KINDERSCENEN: TRAUMEREI (DREAMING)
10/28 04:07:31 Info: [audio/env] [zoneplayer] All streams were disposed
10/28 04:07:31 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [162] {“status”:“Ended”}
10/28 04:07:31 Trace: [snd_rpi_hifiberry_dacplus] [raatclient] GOT [164] {“status”:“Success”}
10/28 04:07:31 Info: sleep 39ms after flush
10/28 04:07:31 Warn: [zoneplayer/raat] Error during streaming: System.NullReferenceException: Object reference not set to an instance of an object.
at Sooloos.Broker.Transport.RaatZonePlayer.<>c__DisplayClass31_0.<_StartStream4>b__1()
10/28 04:07:31 Info: [Bedroom] [zoneplayer] Playing: channel://icy%3a%2f%2fprod-35-199-150-166.wostreaming.net%2fmzmedia-cfmzfmmp3-ibc2%3fsession-id%3d0ff4b13e5d5989401f235959bbc6325f%26source%3dTuneIn
10/28 04:07:32 Trace: Got ICY Stream Title [ROBERT SCHUMANN (1810-1856) GER - KINDERSCENEN: TRAUMEREI (DREAMING)]
10/28 04:07:33 Info: [Bedroom] [zoneplayer] Open Result (Playing):Result[Status=Success]
10/28 04:07:33 Info: [Bedroom] [zoneplayer] Aborting play because track changed
10/28 04:07:33 Warn: [streammediafile] error reading stream: Stream does not support reading.
10/28 04:07:33 Info: [audio/env] [zoneplayer] All streams were disposed

3

Hi @Tim_Pointon,

Is this only happening for www.classicalfm.ca or are you seeing this with other stations as well?

4

@dylan, it happens on other stations as well. I’m not sure if the issue is my LAN or my ISP service. But nothing’s absolutely perfect all the time. What irritates me most is that there is no feedback on the controller … it’s just as though I pressed “Stop”, except I didn’t. For once I might be missing Microsoft’s “Abandon, Retry, Ignore”.

In full disclosure, I must point out that this Raspberry Pi is on a PowerLine to a Gb switch. I was experiencing the same issue on WiFi and thought Ethernet might solve it, albeit PowerLine … I cannot run a wire to the switch 2 floors down. When on WiFi I have a Linksys Velop mesh with an a access point on each of 3 floors.

5

Thanks for the details, @Tim_Pointon.

How often does this occur?

If possible, could you try playing to something besides the Pi as a test? It would be helpful to know if this is limited to that one endpoint or if it’s a general issue.

6

This topic was automatically closed 365 days after the last reply. New replies are no longer allowed.