2025-08-07 01:23:38.913 DEBUG (MainThread) [music_assistant.player_queues] (pre)loading (next) item for queue steini... 2025-08-07 01:23:38.918 DEBUG (MainThread) [music_assistant.audio] Getting streamdetails for library://track/669 2025-08-07 01:23:38.922 DEBUG (MainThread) [music_assistant.audio] retrieved streamdetails for library://track/669 in 4 milliseconds 2025-08-07 01:23:38.923 DEBUG (MainThread) [music_assistant.audio.cache] Creating audio cache for spotify://track/0xReOUsi0sEAYovbpxk7hr 2025-08-07 01:23:38.926 DEBUG (MainThread) [ffmpeg.153] Start reading audio data from source... 2025-08-07 01:23:43.929 WARNING (MainThread) [music_assistant.spotify] No audio received from librespot within timeout - will retry once 2025-08-07 01:23:48.931 DEBUG (MainThread) [music_assistant.helpers.process.librespot] Process librespot with PID 154 did not stop in time. Sending terminate... 2025-08-07 01:23:56.985 DEBUG (MainThread) [music_assistant.webserver] Handling command builtin_player/register 2025-08-07 01:24:03.939 DEBUG (MainThread) [music_assistant.helpers.process.librespot] Process librespot with PID 168 did not stop in time. Sending terminate... 2025-08-07 01:24:03.943 ERROR (MainThread) [ffmpeg.153] Stream error: No audio received from librespot within timeout Traceback (most recent call last): File "/usr/local/lib/python3.12/asyncio/tasks.py", line 520, in wait_for return await fut ^^^^^^^^^ File "/app/venv/lib/python3.12/site-packages/music_assistant/helpers/process.py", line 137, in read return await self.proc.stdout.read(n) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.12/asyncio/streams.py", line 713, in read await self._wait_for_data('read') File "/usr/local/lib/python3.12/asyncio/streams.py", line 545, in _wait_for_data await self._waiter asyncio.exceptions.CancelledError 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/providers/spotify/__init__.py", line 610, in get_audio_stream chunk = await asyncio.wait_for(librespot_proc.read(64000), timeout=5 * attempt) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.12/asyncio/tasks.py", line 519, in wait_for async with timeouts.timeout(timeout): ^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.12/asyncio/timeouts.py", line 115, in __aexit__ raise TimeoutError from exc_val TimeoutError During handling of the above exception, another exception occurred: 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/providers/spotify/__init__.py", line 617, in get_audio_stream raise AudioError(err_mesg) music_assistant_models.errors.AudioError: No audio received from librespot within timeout 2025-08-07 01:24:03.955 WARNING (MainThread) [ffmpeg.153] [in#0 @ 0x7f422a6c8800] Error opening input: Invalid data found when processing input Error opening input file -. Error opening input files: Invalid data found when processing input 2025-08-07 01:24:03.955 ERROR (MainThread) [music_assistant.audio.cache] Error while creating cache for spotify://track/0xReOUsi0sEAYovbpxk7hr: FFMpeg error 183 2025-08-07 01:24:03.957 WARNING (MainThread) [music_assistant.player_queues] Skipping unplayable item Phil Laude/Yung Larry - Lauch (library://track/669) 2025-08-07 01:24:03.958 WARNING (MainThread) [music_assistant] Exception in task Task-364 - target: ._play_index at 0x7f9e51392660>: No playable item found to start playback Traceback (most recent call last): File "/app/venv/lib/python3.12/site-packages/music_assistant/controllers/player_queues.py", line 855, in _play_index raise MediaNotFoundError("No playable item found to start playback") music_assistant_models.errors.MediaNotFoundError: No playable item found to start playback