Add debug logging to audio.py (#692)

* Add debug logging

* Update music_assistant/server/helpers/audio.py

Co-authored-by: Marcel van der Veldt <m.vanderveldt@outlook.com>
* Update music_assistant/server/helpers/audio.py

Co-authored-by: Marcel van der Veldt <m.vanderveldt@outlook.com>
---------

Co-authored-by: Marcel van der Veldt <m.vanderveldt@outlook.com>

diff --git a/music_assistant/server/helpers/audio.py b/music_assistant/server/helpers/audio.py
index c83be685d046b751f44d4ed1e2e4f1bac8790e10..a423adcfd8ab36ab9676c25a1ee3ba2c7d1a3da0 100644 (file)
--- a/music_assistant/server/helpers/audio.py
+++ b/music_assistant/server/helpers/audio.py
@@ -238,6 +238,7 @@ async def get_stream_details(mass: MusicAssistant, queue_item: QueueItem) -> Str
     """
     streamdetails = None
     if queue_item.streamdetails and (time() < (queue_item.streamdetails.expires - 360)):
+        LOGGER.debug(f"Using cached streamdetails for {queue_item.uri}")
         # we already have fresh streamdetails, use these
         queue_item.streamdetails.seconds_skipped = None
         queue_item.streamdetails.seconds_streamed = None
@@ -251,10 +252,12 @@ async def get_stream_details(mass: MusicAssistant, queue_item: QueueItem) -> Str
             full_item.provider_mappings, key=lambda x: x.quality or 0, reverse=True
         ):
             if not prov_media.available:
+                LOGGER.debug(f"Skipping unavailable {prov_media}")
                 continue
             # get streamdetails from provider
             music_prov = mass.get_provider(prov_media.provider_instance)
             if not music_prov:
+                LOGGER.debug(f"Skipping {prov_media} - provider not available")
                 continue  # provider not available ?
             try:
                 streamdetails: StreamDetails = await music_prov.get_stream_details(