Maybe with a bit of luck, anybody here knows any pointers…
(have also posted in this thread: Music assistant error Player does not support enqueueing - work around? - Configuration - Home Assistant Community)
I experience the same (similar) issue as mentioned over in the other thread since shifting over to MA (for years now)…
in a nutshell: radio-streams cut out after x amount of time… between 15 and 100+ seconds after starting the stream…
- only on radio streams (no matter what music provider - Tune-in, radio-browser, … )
- non-radio works fine (spotify)
- Players are all SONOS based (not actual sonos, but the IKEA version)
PS: the “DNS fail” in the logs is strange also… I run adguard and redirect all DNS resolves in my network to it… it shows only successful logs (no blocks, fails, redirects, …) coming from any of the involved hardware…
Will also track - log in the other threads mentioned here…
cutout of the log files from the latest fails (debug enabled on tune-in and sonos)
2025-06-19 17:19:06.027 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://radio/1
2025-06-19 17:19:06.501 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://radio/1 in 474 milliseconds
2025-06-19 17:19:06.799 DEBUG (MainThread) [music_assistant.audio] Generated ffmpeg params for player RINCON_7828CAD351EC01400: ['alimiter=limit=-2dB:level=false:asc=true']
2025-06-19 17:19:06.800 DEBUG (MainThread) [ffmpeg.433] Start reading audio data from source...
2025-06-19 17:19:06.811 DEBUG (MainThread) [music_assistant.audio.media_stream] Started media stream for tunein://radio/s2611--aac - using streamtype: icy - volume normalization: measurement_only - pcm format: f32le - ffmpeg PID: 434
2025-06-19 17:19:06.811 DEBUG (MainThread) [ffmpeg.434] Start reading audio data from source...
2025-06-19 17:19:06.811 DEBUG (MainThread) [music_assistant.audio] Start streaming radio with ICY metadata from url http://icecast.vrtcdn.be/stubru.aac/tunein
2025-06-19 17:19:28.825 ERROR (MainThread) [aiosonos.api] Received unhandled error: {'namespace': 'playback:1', 'householdId': 'Sonos_u0ejWqkgWqaB1HyUx9CqafXLsp.KgYR7b_PGjkMuEZQEKf9', 'locationId': 'lc_52b431106c634618a5dbb9124a782858', 'groupId': 'RINCON_7828CAD351EC01400:2839661934', 'name': 'playbackError', 'type': 'playbackError'}: {'_objectType': 'playbackError', 'errorCode': 'ERROR_PLAYBACK_FAILED', 'reason': 'ERROR_BUFFERING', 'itemId': 'cf469b9c1fbc4759ba50fa0b10ef0c69', 'queueVersion': '1750346346', 'serviceId': 0, 'serviceName': '10.10.10.5:8097', 'trackName': 'Music Assistant'}
2025-06-19 17:19:29.027 DEBUG (MainThread) [music_assistant.audio.media_stream] stream cancelled (with code 255) for tunein://radio/s2611--aac - seconds streamed: 12.0
2025-06-19 17:19:43.605 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://radio/1
2025-06-19 17:19:43.608 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://radio/1 in 2 milliseconds
2025-06-19 17:19:43.745 DEBUG (MainThread) [music_assistant.audio] Generated ffmpeg params for player RINCON_7828CAD351EC01400: ['alimiter=limit=-2dB:level=false:asc=true']
2025-06-19 17:19:43.746 DEBUG (MainThread) [ffmpeg.473] Start reading audio data from source...
2025-06-19 17:19:43.756 DEBUG (MainThread) [music_assistant.audio.media_stream] Started media stream for tunein://radio/s2611--aac - using streamtype: icy - volume normalization: measurement_only - pcm format: f32le - ffmpeg PID: 474
2025-06-19 17:19:43.757 DEBUG (MainThread) [ffmpeg.474] Start reading audio data from source...
2025-06-19 17:19:43.757 DEBUG (MainThread) [music_assistant.audio] Start streaming radio with ICY metadata from url http://icecast.vrtcdn.be/stubru.aac/tunein
2025-06-19 17:20:06.873 ERROR (MainThread) [aiosonos.api] Received unhandled error: {'namespace': 'playback:1', 'householdId': 'Sonos_u0ejWqkgWqaB1HyUx9CqafXLsp.KgYR7b_PGjkMuEZQEKf9', 'locationId': 'lc_52b431106c634618a5dbb9124a782858', 'groupId': 'RINCON_7828CAD351EC01400:2839661934', 'name': 'playbackError', 'type': 'playbackError'}: {'_objectType': 'playbackError', 'errorCode': 'ERROR_PLAYBACK_FAILED', 'reason': 'ERROR_BUFFERING', 'itemId': 'cf469b9c1fbc4759ba50fa0b10ef0c69', 'queueVersion': '1750346346', 'serviceId': 0, 'serviceName': '10.10.10.5:8097', 'trackName': 'Music Assistant'}
2025-06-19 17:20:06.931 DEBUG (MainThread) [music_assistant.audio.media_stream] stream cancelled (with code 255) for tunein://radio/s2611--aac - seconds streamed: 15.0
2025-06-19 17:20:48.643 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://radio/1
2025-06-19 17:20:48.646 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://radio/1 in 2 milliseconds
2025-06-19 17:20:48.745 DEBUG (MainThread) [music_assistant.audio] Generated ffmpeg params for player RINCON_7828CAD351EC01400: ['alimiter=limit=-2dB:level=false:asc=true']
2025-06-19 17:20:48.746 DEBUG (MainThread) [ffmpeg.513] Start reading audio data from source...
2025-06-19 17:20:48.755 DEBUG (MainThread) [music_assistant.audio.media_stream] Started media stream for tunein://radio/s2611--aac - using streamtype: icy - volume normalization: measurement_only - pcm format: f32le - ffmpeg PID: 514
2025-06-19 17:20:48.755 DEBUG (MainThread) [ffmpeg.514] Start reading audio data from source...
2025-06-19 17:20:48.756 DEBUG (MainThread) [music_assistant.audio] Start streaming radio with ICY metadata from url http://icecast.vrtcdn.be/stubru.aac/tunein
2025-06-19 17:23:14.060 ERROR (MainThread) [aiosonos.api] Received unhandled error: {'namespace': 'playback:1', 'householdId': 'Sonos_u0ejWqkgWqaB1HyUx9CqafXLsp.KgYR7b_PGjkMuEZQEKf9', 'locationId': 'lc_52b431106c634618a5dbb9124a782858', 'groupId': 'RINCON_7828CAD351EC01400:2839661934', 'name': 'playbackError', 'type': 'playbackError'}: {'_objectType': 'playbackError', 'errorCode': 'ERROR_PLAYBACK_FAILED', 'reason': 'ERROR_BUFFERING', 'itemId': 'cf469b9c1fbc4759ba50fa0b10ef0c69', 'queueVersion': '1750346346', 'serviceId': 0, 'serviceName': '10.10.10.5:8097', 'trackName': 'Music Assistant'}
2025-06-19 17:23:15.451 DEBUG (MainThread) [music_assistant.audio.media_stream] stream cancelled (with code 255) for tunein://radio/s2611--aac - seconds streamed: 135.0
2025-06-19 17:24:48.859 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://radio/1
2025-06-19 17:24:48.861 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://radio/1 in 2 milliseconds
2025-06-19 17:24:48.950 DEBUG (MainThread) [music_assistant.audio] Generated ffmpeg params for player RINCON_7828CAD351EC01400: ['alimiter=limit=-2dB:level=false:asc=true']
2025-06-19 17:24:48.951 DEBUG (MainThread) [ffmpeg.553] Start reading audio data from source...
2025-06-19 17:24:48.962 DEBUG (MainThread) [music_assistant.audio.media_stream] Started media stream for tunein://radio/s2611--aac - using streamtype: icy - volume normalization: measurement_only - pcm format: f32le - ffmpeg PID: 554
2025-06-19 17:24:48.962 DEBUG (MainThread) [ffmpeg.554] Start reading audio data from source...
2025-06-19 17:24:48.962 DEBUG (MainThread) [music_assistant.audio] Start streaming radio with ICY metadata from url http://icecast.vrtcdn.be/stubru.aac/tunein
2025-06-19 17:34:54.111 DEBUG (MainThread) [music_assistant.audio.media_stream] stream cancelled (with code 255) for tunein://radio/s2611--aac - seconds streamed: 594.0
2025-06-19 17:34:54.785 ERROR (MainThread) [aiosonos.api] Received unhandled error: {'namespace': 'playback:1', 'householdId': 'Sonos_u0ejWqkgWqaB1HyUx9CqafXLsp.KgYR7b_PGjkMuEZQEKf9', 'locationId': 'lc_52b431106c634618a5dbb9124a782858', 'groupId': 'RINCON_7828CAD351EC01400:2839661934', 'name': 'playbackError', 'type': 'playbackError'}: {'_objectType': 'playbackError', 'errorCode': 'ERROR_PLAYBACK_FAILED', 'reason': 'ERROR_BUFFERING', 'itemId': 'cf469b9c1fbc4759ba50fa0b10ef0c69', 'queueVersion': '1750346346', 'serviceId': 0, 'serviceName': '10.10.10.5:8097', 'trackName': 'Music Assistant'}
2025-06-19 17:36:54.798 DEBUG (MainThread) [music_assistant.sonos] Ignoring Kamer Kyan in discovery as it is a passive satellite.
2025-06-19 17:42:09.039 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://radio/1
2025-06-19 17:42:09.041 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://radio/1 in 2 milliseconds
2025-06-19 17:42:09.162 DEBUG (MainThread) [music_assistant.audio] Generated ffmpeg params for player RINCON_7828CAD351EC01400: ['alimiter=limit=-2dB:level=false:asc=true']
2025-06-19 17:42:09.164 DEBUG (MainThread) [ffmpeg.593] Start reading audio data from source...
2025-06-19 17:42:09.173 DEBUG (MainThread) [music_assistant.audio.media_stream] Started media stream for tunein://radio/s2611--aac - using streamtype: icy - volume normalization: measurement_only - pcm format: f32le - ffmpeg PID: 594
2025-06-19 17:42:09.173 DEBUG (MainThread) [ffmpeg.594] Start reading audio data from source...
2025-06-19 17:42:09.173 DEBUG (MainThread) [music_assistant.audio] Start streaming radio with ICY metadata from url http://icecast.vrtcdn.be/stubru.aac/tunein
2025-06-19 17:42:10.614 ERROR (MainThread) [ffmpeg.594] Stream error: Cannot connect to host vrt.streamabc.net:80 ssl:default [Timeout while contacting DNS servers]
Traceback (most recent call last):
File "/app/venv/lib/python3.12/site-packages/aiohttp/resolver.py", line 106, in resolve
resp = await self._resolver.getaddrinfo(
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
aiodns.error.DNSError: (12, 'Timeout while contacting DNS servers')
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 1357, in _create_direct_connection
hosts = await self._resolve_host(host, port, traces=traces)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 995, in _resolve_host
return await asyncio.shield(resolved_host_task)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 1026, in _resolve_host_with_throttle
addrs = await self._resolver.resolve(host, port, family=self._family)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/resolver.py", line 115, in resolve
raise OSError(None, msg) from exc
OSError: [Errno None] Timeout while contacting DNS servers
The above exception was the direct cause of the following exception:
Traceback (most recent call last):
File "/app/venv/lib/python3.12/site-packages/music_assistant/helpers/ffmpeg.py", line 171, in _feed_stdin
async for chunk in self.audio_input:
File "/app/venv/lib/python3.12/site-packages/music_assistant/helpers/audio.py", line 1059, in get_icy_radio_stream
async with mass.http_session.get(
^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/client.py", line 1425, in __aenter__
self._resp: _RetType = await self._coro
^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/client.py", line 703, in _request
conn = await self._connector.connect(
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 548, in connect
proto = await self._create_connection(req, traces, timeout)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 1056, in _create_connection
_, proto = await self._create_direct_connection(req, traces, timeout)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/app/venv/lib/python3.12/site-packages/aiohttp/connector.py", line 1363, in _create_direct_connection
raise ClientConnectorDNSError(req.connection_key, exc) from exc
aiohttp.client_exceptions.ClientConnectorDNSError: Cannot connect to host vrt.streamabc.net:80 ssl:default [Timeout while contacting DNS servers]
2025-06-19 17:42:10.618 ERROR (MainThread) [music_assistant.audio.media_stream] Error while streaming tunein://radio/s2611--aac: No audio was received
2025-06-19 17:42:10.618 WARNING (MainThread) [music_assistant.audio.media_stream] [in#0 @ 0x14752295ec00] Error opening input: Invalid data found when processing input
Error opening input file -.
Error opening input files: Invalid data found when processing input
2025-06-19 17:42:10.618 DEBUG (MainThread) [music_assistant.audio.media_stream] stream aborted (with code 183) for tunein://radio/s2611--aac - seconds streamed: 0
2025-06-19 17:42:10.618 DEBUG (MainThread) [ffmpeg.593] Audio data source exhausted in 1.45s
2025-06-19 17:42:10.640 ERROR (MainThread) [music_assistant.streams] Error streaming QueueItem VRT Studio Brussel (library://radio/1) to Kitchen
2025-06-19 17:43:55.838 DEBUG (MainThread) [music_assistant.tunein] Log level configured to DEBUG
2025-06-19 17:43:55.838 INFO (MainThread) [music_assistant] Loaded music provider Tune-In Radio

