search

music-assistant / hass-music-assistant

Turn your Home Assistant instance into a jukebox, hassle free streaming of your favorite media to Home Assistant media players.
Apache License 2.0
1.34k stars 50 forks source link

Bets (32) UI not loading #1269

Closed DravenSA closed 1 year ago

DravenSA commented 1 year ago

What version of Music Assistant has the issue?

Beta (32)

The problem

Updated to the new Beta 32 and now the UI wont load

How to reproduce

Updated to Beta 32

Relevant log output

2023-05-29 10:01:23 INFO  music_assistant.metadata  -- Unable to get musicbrainz ID for artist Gorillaz feat. Vince Staples
 - using lookup-album(s): none
 - using lookup-track(s): Ascension
2023-05-29 10:01:44 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.112 seconds
2023-05-29 10:02:02 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.322 seconds
2023-05-29 10:02:03 WARNING asyncio  -- Executing <Task pending name='Task-451' coro=<to_thread() running at /usr/local/lib/python3.11/asyncio/threads.py:25> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:291> took 0.550 seconds
2023-05-29 10:02:07 INFO  music_assistant.metadata  -- Unable to get musicbrainz ID for artist Hotel Head
 - using lookup-album(s): Demo
 - using lookup-track(s): Hotel Head/Plastic Man/Bury The Addict
2023-05-29 10:02:37 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.620 seconds
2023-05-29 10:02:37 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.105 seconds
2023-05-29 10:03:10 WARNING asyncio  -- Executing <Task pending name='Task-34' coro=<MetaDataController.start_scan.<locals>.scan_artist_metadata() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/metadata.py:99> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.141 seconds
2023-05-29 10:03:10 WARNING asyncio  -- Executing <Task pending name='Task-34' coro=<MetaDataController.start_scan.<locals>.scan_artist_metadata() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/metadata.py:99> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.107 seconds
2023-05-29 10:03:11 WARNING asyncio  -- Executing <Task pending name='Task-34' coro=<MetaDataController.start_scan.<locals>.scan_artist_metadata() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/metadata.py:99> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.100 seconds
2023-05-29 10:03:12 WARNING asyncio  -- Executing <Task pending name='Task-486' coro=<ArtistsController.get_provider_artist_albums() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:255> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[gather.<locals>._done_callback() at /usr/local/lib/python3.11/asyncio/tasks.py:754] created at /usr/local/lib/python3.11/asyncio/tasks.py:670> took 0.111 seconds
2023-05-29 10:03:14 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.122 seconds
2023-05-29 10:03:14 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.134 seconds
2023-05-29 10:03:15 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[shield.<locals>._outer_done_callback() at /usr/local/lib/python3.11/asyncio/tasks.py:898, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.347 seconds
2023-05-29 10:03:17 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.422 seconds
2023-05-29 10:03:17 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.304 seconds
2023-05-29 10:03:18 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[shield.<locals>._outer_done_callback() at /usr/local/lib/python3.11/asyncio/tasks.py:898, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.325 seconds
2023-05-29 10:03:18 WARNING asyncio  -- Executing <Task pending name='Task-492' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.140 seconds
2023-05-29 10:03:19 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[BaseSelectorEventLoop._sock_write_done(21, handle=<Handle BaseS...events.py:300>)(), Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.179 seconds
2023-05-29 10:03:19 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.128 seconds
2023-05-29 10:03:19 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.139 seconds
2023-05-29 10:03:20 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.447 seconds
2023-05-29 10:03:20 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.175 seconds
2023-05-29 10:03:20 WARNING asyncio  -- Executing <Task pending name='Task-495' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.540 seconds
2023-05-29 10:03:21 WARNING asyncio  -- Executing <TimerHandle when=229400.055012645 StreamsController._cleanup_stale.<locals>.reschedule() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/streams.py:712 created at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/streams.py:715> took 0.127 seconds
2023-05-29 10:03:21 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.118 seconds
2023-05-29 10:03:22 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.658 seconds
2023-05-29 10:03:22 WARNING asyncio  -- Executing <Task pending name='Task-495' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.119 seconds
2023-05-29 10:03:22 WARNING asyncio  -- Executing <Handle _SelectorSocketTransport._read_ready() created at /usr/local/lib/python3.11/asyncio/selector_events.py:263> took 0.123 seconds
2023-05-29 10:03:23 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.245 seconds
2023-05-29 10:03:23 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.103 seconds
2023-05-29 10:03:24 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.459 seconds
2023-05-29 10:03:24 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.167 seconds
2023-05-29 10:03:24 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.140 seconds
2023-05-29 10:03:26 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.555 seconds
2023-05-29 10:03:26 WARNING asyncio  -- Executing <Task pending name='Task-500' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.101 seconds
2023-05-29 10:03:26 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.291 seconds
2023-05-29 10:03:27 WARNING asyncio  -- Executing <Handle _chain_future.<locals>._set_state(<Future finis...events.py:427>, <Future at 0x... returned str>) at /usr/local/lib/python3.11/asyncio/futures.py:381 created at /usr/local/lib/python3.11/asyncio/futures.py:403> took 0.111 seconds
2023-05-29 10:03:27 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.132 seconds
2023-05-29 10:03:28 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.573 seconds
2023-05-29 10:03:28 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.199 seconds
2023-05-29 10:03:28 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.145 seconds
2023-05-29 10:03:28 WARNING asyncio  -- Executing <Task pending name='Task-504' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.130 seconds
2023-05-29 10:03:29 WARNING asyncio  -- Executing <Task pending name='Task-502' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.104 seconds
2023-05-29 10:03:29 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.128 seconds
2023-05-29 10:03:30 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.628 seconds
2023-05-29 10:03:31 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.287 seconds
2023-05-29 10:03:32 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.293 seconds
2023-05-29 10:03:32 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.224 seconds
2023-05-29 10:03:33 WARNING asyncio  -- Executing <Task pending name='Task-508' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.132 seconds
2023-05-29 10:03:34 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.585 seconds
2023-05-29 10:03:34 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.204 seconds
2023-05-29 10:03:36 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.327 seconds
2023-05-29 10:03:36 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.214 seconds
2023-05-29 10:03:36 WARNING asyncio  -- Executing <Task pending name='Task-512' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.154 seconds
2023-05-29 10:03:37 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.506 seconds
2023-05-29 10:03:38 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.224 seconds
2023-05-29 10:03:38 WARNING asyncio  -- Executing <Task pending name='Task-514' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> created at /usr/local/lib/python3.11/asyncio/tasks.py:374> took 0.118 seconds
2023-05-29 10:03:39 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:62> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.417 seconds
2023-05-29 10:03:39 INFO  music_assistant.metadata  -- Unable to get musicbrainz ID for artist Jesus 'Sixto' Rodriguez
 - using lookup-album(s): none
 - using lookup-track(s): Sugar Man/Only Good For Conversation/Crucify Your Mind/This Is Not A Song, It's An Outburst: Or, The Establishment Blues/Hate Street Dialogue/Forget It/Inner City Blues/I Wonder/Like Janis/Gommorah (A Nursery Rhyme)/Jane S. Piddy
2023-05-29 10:03:39 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:64> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.179 seconds
2023-05-29 10:03:40 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.737 seconds
2023-05-29 10:03:42 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:64> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.105 seconds
2023-05-29 10:03:43 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:64> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.121 seconds
2023-05-29 10:03:44 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.106 seconds
2023-05-29 10:03:44 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.106 seconds
2023-05-29 10:03:47 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.110 seconds
2023-05-29 10:03:48 WARNING asyncio  -- Executing <Handle _chain_future.<locals>._set_state(<Future finis...events.py:427>, <Future at 0x...returned list>) at /usr/local/lib/python3.11/asyncio/futures.py:381 created at /usr/local/lib/python3.11/asyncio/futures.py:403> took 0.106 seconds
2023-05-29 10:03:48 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.163 seconds
2023-05-29 10:03:48 WARNING asyncio  -- Executing <TimerHandle cancelled when=229428 _weakref_handle((<weakref at 0...x7f83dd24a550>, '_cleanup')) at /usr/local/lib/python3.11/site-packages/aiohttp/helpers.py:595 created at /usr/local/lib/python3.11/site-packages/aiohttp/helpers.py:611> took 0.101 seconds
2023-05-29 10:03:49 WARNING asyncio  -- Executing <Task pending name='Task-518' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.115 seconds
2023-05-29 10:03:52 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.311 seconds
2023-05-29 10:03:53 WARNING asyncio  -- Executing <Task pending name='Task-519' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.143 seconds
2023-05-29 10:03:53 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.131 seconds
2023-05-29 10:03:54 WARNING asyncio  -- Executing <Handle Connection.run.<locals>.set_result(<Future finis...events.py:427>, <sqlite3.Curs...x7f8369227d40>) at /usr/local/lib/python3.11/site-packages/aiosqlite/core.py:109 created at /usr/local/lib/python3.11/site-packages/aiosqlite/core.py:113> took 0.123 seconds
2023-05-29 10:03:54 WARNING asyncio  -- Executing <Task pending name='Task-519' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.107 seconds
2023-05-29 10:03:55 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.135 seconds
2023-05-29 10:03:58 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.124 seconds
2023-05-29 10:03:58 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.164 seconds
2023-05-29 10:03:58 WARNING asyncio  -- Executing <Task pending name='Task-520' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:93> wait_for=<Future pending cb=[_chain_future.<locals>._call_check_cancel() at /usr/local/lib/python3.11/asyncio/futures.py:387, Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.153 seconds
2023-05-29 10:03:58 WARNING asyncio  -- Executing <Handle Connection.run.<locals>.set_result(<Future finis...events.py:427>, <sqlite3.Curs...x7f83d899c840>) at /usr/local/lib/python3.11/site-packages/aiosqlite/core.py:109 created at /usr/local/lib/python3.11/site-packages/aiosqlite/core.py:113> took 0.124 seconds
2023-05-29 10:03:59 WARNING asyncio  -- Executing <Task pending name='Task-520' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.101 seconds
2023-05-29 10:03:59 WARNING asyncio  -- Executing <Task pending name='Task-520' coro=<CacheController.set() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/cache.py:94> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.111 seconds
2023-05-29 10:04:00 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.126 seconds
2023-05-29 10:04:02 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.120 seconds
2023-05-29 10:04:03 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.169 seconds
2023-05-29 10:04:04 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.113 seconds
2023-05-29 10:04:07 WARNING asyncio  -- Executing <Task pending name='Task-6' coro=<PlayerController._poll_players() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/players.py:616> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.114 seconds
2023-05-29 10:04:07 WARNING asyncio  -- Executing <Task pending name='Task-485' coro=<ArtistsController.add() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/media/artists.py:71> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, Task.task_wakeup()] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:284> took 0.132 seconds
2023-05-29 10:04:40 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 31.546 seconds
2023-05-29 10:04:53 WARNING asyncio  -- Executing <Task pending name='Task-190' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 13.136 seconds

Additional information

No response

What version of Home Assistant Core are your running

2023.5.4

What type of installation are you running?

Home Assistant OS

On what type of hardware are you running?

Generic x86-64 (e.g. Intel NUC)

MarvinSchenkel commented 1 year ago

Can you tell me a bit more about your installation? For example, how much resources (CPU and RAM) did you give you HA installation? The logs make me think you do not have enough resources to properly run MA.

DravenSA commented 1 year ago

Strangely enough i had to reboot the entire device to get it to work., not just a restart, but a full reboot. Machine is a Dell Wyse 3050, i5, 16gb ram, and 250gb ssd, so it wasnt hardware, but a reboot that was fully needed. restarted 3 times, then sent the message. then rebooted and it works now.

marcelveldt commented 1 year ago

Somehow the machine was fully occupied with something, those warnings in the logs clearly indicating the eventloop suffering a lack of resources. Good that a full machine restart fixed it but when it happens again, check all your processes/add-ons what is consuming all these resources.

DravenSA commented 1 year ago

just went back to play some music and the UI wont load again , the only log i can see with error are below

Logger: aiohttp.server
Source: /usr/local/lib/python3.10/site-packages/aiohttp/web_protocol.py:403
First occurred: 14:06:26 (1 occurrences)
Last logged: 14:06:26

Unhandled exception
Traceback (most recent call last):
  File "/usr/local/lib/python3.10/asyncio/base_events.py", line 1205, in _sendfile_fallback
    read = await self.run_in_executor(None, file.readinto, view)
asyncio.exceptions.CancelledError

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.10/site-packages/aiohttp/web_protocol.py", line 512, in start
    resp, reset = await task
  File "/usr/local/lib/python3.10/site-packages/aiohttp/web_protocol.py", line 458, in _handle_request
    reset = await self.finish_response(request, resp, start_time)
  File "/usr/local/lib/python3.10/site-packages/aiohttp/web_protocol.py", line 611, in finish_response
    await prepare_meth(request)
  File "/usr/local/lib/python3.10/site-packages/aiohttp/web_fileresponse.py", line 286, in prepare
    return await self._sendfile(request, fobj, offset, count)
  File "/usr/local/lib/python3.10/site-packages/aiohttp/web_fileresponse.py", line 99, in _sendfile
    await loop.sendfile(transport, fobj, offset, count)
  File "/usr/local/lib/python3.10/asyncio/base_events.py", line 1184, in sendfile
    return await self._sendfile_fallback(transport, file,
  File "/usr/local/lib/python3.10/asyncio/base_events.py", line 1214, in _sendfile_fallback
    await proto.restore()
  File "/usr/local/lib/python3.10/asyncio/base_events.py", line 268, in restore
    self._transport.resume_reading()
  File "/usr/local/lib/python3.10/asyncio/sslproto.py", line 343, in resume_reading
    self._ssl_protocol._transport.resume_reading()
AttributeError: 'NoneType' object has no attribute 'resume_reading'

I have no idea if this is to do with the Music assistant, but it is the ONLY error /warning i have in the logs

DravenSA commented 1 year ago

i set the logs for Music Assistant to debug, and it looks like it is connecting to the speakers and such like, but it just wont load the UI

2023-05-29 14:04:27 DEBUG pychromecast  -- get_chromecast_from_cast_info CastInfo(services={ServiceInfo(type='mdns', data='Google-Cast-Group-d5bbe9ff0f694a2aa9e3cf15c19bbaca._googlecast._tcp.local.')}, uuid=UUID('d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca'), model_name='Google Cast Group', friendly_name='Full House', host='192.168.0.67', port=32094, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Office speaker got new cast status for group: a70c9d04-0dbf-40de-9b38-df309f860cb3
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Full House  -- Received connection status update - status: CONNECTING
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Office speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Lounge speaker got new cast status for group: a70c9d04-0dbf-40de-9b38-df309f860cb3
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Lounge speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Working House  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 INFO  music_assistant.players  -- Player registered: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca/Full House
2023-05-29 14:04:27 DEBUG music_assistant.event  -- player_added d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.event  -- player_updated d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.event  -- player_updated a70c9d04-0dbf-40de-9b38-df309f860cb3
2023-05-29 14:04:27 DEBUG music_assistant.event  -- queue_updated d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Full House  -- Received connection status update - status: CONNECTED
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- [Full House] Cast device availability changed: CONNECTED
2023-05-29 14:04:27 DEBUG music_assistant.event  -- queue_updated d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.event  -- player_updated d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Kitchen speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Kitchen speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Red Room Speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Red Room Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Bunny Speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Bunny Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Lounge speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Lounge speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Bedroom Speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Bedroom Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Office speaker is added to multizone: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Office speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Kitchen speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Kitchen speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Red Room Speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Red Room Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Bunny Speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Bunny Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Lounge speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Lounge speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Bedroom Speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Bedroom Speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast  -- Office speaker got new cast status for group: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Office speaker  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.providers.chromecast.Full House  -- Received cast status - app_id: None - volume: 0.4000000059604645
2023-05-29 14:04:27 DEBUG music_assistant.event  -- player_updated d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca
2023-05-29 14:04:28 DEBUG music_assistant.providers.ytmusic  -- Start sync of track items.
2023-05-29 14:04:31 DEBUG music_assistant.providers.ytmusic  -- Start sync of playlist items.
2023-05-29 14:04:33 DEBUG music_assistant.music.playlist  -- updated Your Likes in database: 2
2023-05-29 14:04:33 DEBUG music_assistant.music.playlist  -- updated Carry On My Wayward Son (inspired by Dean's Playlist (Supernatural)) in database: 11
2023-05-29 14:04:34 DEBUG music_assistant.providers.plex  -- Start sync of artist items.
2023-05-29 14:04:34 DEBUG music_assistant.event  -- sync_tasks_updated 
2023-05-29 14:04:36 DEBUG music_assistant.providers.plex  -- Start sync of album items.
2023-05-29 14:04:48 DEBUG music_assistant.providers.plex  -- Start sync of track items.
2023-05-29 14:04:52 DEBUG music_assistant.metadata  -- Finished scan for missing artist metadata
2023-05-29 14:04:52 DEBUG pychromecast.discovery  -- Host 192.168.0.7:8009 (b448786b-ee21-2e5a-8b80-4fcfcf83b5e5) up, adding or updating host based service
2023-05-29 14:04:52 DEBUG music_assistant.providers.chromecast  -- Ignoring disabled player: b448786b-ee21-2e5a-8b80-4fcfcf83b5e5
2023-05-29 14:04:52 DEBUG pychromecast.discovery  -- Addded host [::ffff:c0a8:43]
2023-05-29 14:04:52 DEBUG pychromecast.discovery  -- Addded host [::ffff:c0a8:47]
2023-05-29 14:04:52 DEBUG pychromecast.discovery  -- Host 192.168.0.70:8009 (bcc59d8b-a0e7-c785-1c5d-3287c0d8f940) up, adding or updating host based service
2023-05-29 14:04:52 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Home-Mini-bcc59d8ba0e7c7851c5d3287c0d8f940._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.70', 8009))}, uuid=UUID('bcc59d8b-a0e7-c785-1c5d-3287c0d8f940'), model_name='Google Home Mini', friendly_name='Red Room Speaker', host='192.168.0.70', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:53 DEBUG pychromecast.discovery  -- Host 192.168.0.68:8009 (51a22972-195f-b3ac-0e7e-55ae6d0f6021) up, adding or updating host based service
2023-05-29 14:04:53 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.68', 8009)), ServiceInfo(type='mdns', data='Google-Home-Mini-51a22972195fb3ac0e7e55ae6d0f6021._googlecast._tcp.local.')}, uuid=UUID('51a22972-195f-b3ac-0e7e-55ae6d0f6021'), model_name='Google Home Mini', friendly_name='Office speaker', host='192.168.0.68', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:53 DEBUG pychromecast.discovery  -- Host 192.168.0.72:8009 (d516bd4f-ef28-f9da-3074-69235aa8c9c0) up, adding or updating host based service
2023-05-29 14:04:53 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.72', 8009)), ServiceInfo(type='mdns', data='Google-Home-Mini-d516bd4fef28f9da307469235aa8c9c0._googlecast._tcp.local.')}, uuid=UUID('d516bd4f-ef28-f9da-3074-69235aa8c9c0'), model_name='Google Home Mini', friendly_name='Bedroom Speaker', host='192.168.0.72', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:53 DEBUG pychromecast.discovery  -- Host 192.168.0.69:8009 (88dfb459-3b47-0e07-272e-e8693906aa57) up, adding or updating host based service
2023-05-29 14:04:53 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.69', 8009)), ServiceInfo(type='mdns', data='Google-Home-Mini-88dfb4593b470e07272ee8693906aa57._googlecast._tcp.local.')}, uuid=UUID('88dfb459-3b47-0e07-272e-e8693906aa57'), model_name='Google Home Mini', friendly_name='Garage speaker', host='192.168.0.69', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:53 DEBUG pychromecast.discovery  -- Host 192.168.0.37:8009 (474bed6d-b916-0f5a-cac8-050371bb14f8) up, adding or updating host based service
2023-05-29 14:04:53 DEBUG music_assistant.providers.chromecast  -- Ignoring disabled player: 474bed6d-b916-0f5a-cac8-050371bb14f8
2023-05-29 14:04:53 DEBUG pychromecast.discovery  -- Host 192.168.0.66:8009 (6d50cf81-c324-69bf-bef2-c140549b5d73) up, adding or updating host based service
2023-05-29 14:04:53 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Home-Mini-6d50cf81c32469bfbef2c140549b5d73._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.66', 8009))}, uuid=UUID('6d50cf81-c324-69bf-bef2-c140549b5d73'), model_name='Google Home Mini', friendly_name='Lounge speaker', host='192.168.0.66', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.71:8009 (96a45d9e-0e89-5979-c40b-2399428852ee) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.71:32162 (05e030ca-4c83-4005-95ae-cd78cbad25f2) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Home-Mini-96a45d9e0e895979c40b2399428852ee._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.71', 8009))}, uuid=UUID('96a45d9e-0e89-5979-c40b-2399428852ee'), model_name='Google Home Mini', friendly_name='Bunny Speaker', host='192.168.0.71', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Cast-Group-05e030ca4c83400595aecd78cbad25f2._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.71', 32162))}, uuid=UUID('05e030ca-4c83-4005-95ae-cd78cbad25f2'), model_name='Google Cast Group', friendly_name='Kids', host='192.168.0.71', port=32162, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.67:8009 (dc21c3e7-63de-850e-ca2e-b250a15de0c6) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.67:32059 (02461001-8826-4cf8-a211-6571f1977636) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.67:32028 (4cf1d020-fd07-4ed0-8f3a-9446b57962fc) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.67:32237 (a70c9d04-0dbf-40de-9b38-df309f860cb3) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG pychromecast.discovery  -- Host 192.168.0.67:32094 (d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca) up, adding or updating host based service
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Home-Mini-dc21c3e763de850eca2eb250a15de0c6._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.67', 8009))}, uuid=UUID('dc21c3e7-63de-850e-ca2e-b250a15de0c6'), model_name='Google Home Mini', friendly_name='Kitchen speaker', host='192.168.0.67', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32059)), ServiceInfo(type='mdns', data='Google-Cast-Group-0246100188264cf8a2116571f1977636._googlecast._tcp.local.')}, uuid=UUID('02461001-8826-4cf8-a211-6571f1977636'), model_name='Google Cast Group', friendly_name='Morning', host='192.168.0.67', port=32059, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32028)), ServiceInfo(type='mdns', data='Google-Cast-Group-4cf1d020fd074ed08f3a9446b57962fc._googlecast._tcp.local.')}, uuid=UUID('4cf1d020-fd07-4ed0-8f3a-9446b57962fc'), model_name='Google Cast Group', friendly_name='Working', host='192.168.0.67', port=32028, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32237)), ServiceInfo(type='mdns', data='Google-Cast-Group-a70c9d040dbf40de9b38df309f860cb3._googlecast._tcp.local.')}, uuid=UUID('a70c9d04-0dbf-40de-9b38-df309f860cb3'), model_name='Google Cast Group', friendly_name='Working House', host='192.168.0.67', port=32237, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:04:54 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32094)), ServiceInfo(type='mdns', data='Google-Cast-Group-d5bbe9ff0f694a2aa9e3cf15c19bbaca._googlecast._tcp.local.')}, uuid=UUID('d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca'), model_name='Google Cast Group', friendly_name='Full House', host='192.168.0.67', port=32094, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:43]:8009 (dc21c3e7-63de-850e-ca2e-b250a15de0c6) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:43]:32059 (02461001-8826-4cf8-a211-6571f1977636) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:43]:32028 (4cf1d020-fd07-4ed0-8f3a-9446b57962fc) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:43]:32237 (a70c9d04-0dbf-40de-9b38-df309f860cb3) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:43]:32094 (d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('[::ffff:c0a8:43]', 8009)), ServiceInfo(type='mdns', data='Google-Home-Mini-dc21c3e763de850eca2eb250a15de0c6._googlecast._tcp.local.'), ServiceInfo(type='host', data=('192.168.0.67', 8009))}, uuid=UUID('dc21c3e7-63de-850e-ca2e-b250a15de0c6'), model_name='Google Home Mini', friendly_name='Kitchen speaker', host='[::ffff:c0a8:43]', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('[::ffff:c0a8:43]', 32059)), ServiceInfo(type='host', data=('192.168.0.67', 32059)), ServiceInfo(type='mdns', data='Google-Cast-Group-0246100188264cf8a2116571f1977636._googlecast._tcp.local.')}, uuid=UUID('02461001-8826-4cf8-a211-6571f1977636'), model_name='Google Cast Group', friendly_name='Morning', host='[::ffff:c0a8:43]', port=32059, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32028)), ServiceInfo(type='host', data=('[::ffff:c0a8:43]', 32028)), ServiceInfo(type='mdns', data='Google-Cast-Group-4cf1d020fd074ed08f3a9446b57962fc._googlecast._tcp.local.')}, uuid=UUID('4cf1d020-fd07-4ed0-8f3a-9446b57962fc'), model_name='Google Cast Group', friendly_name='Working', host='[::ffff:c0a8:43]', port=32028, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32237)), ServiceInfo(type='mdns', data='Google-Cast-Group-a70c9d040dbf40de9b38df309f860cb3._googlecast._tcp.local.'), ServiceInfo(type='host', data=('[::ffff:c0a8:43]', 32237))}, uuid=UUID('a70c9d04-0dbf-40de-9b38-df309f860cb3'), model_name='Google Cast Group', friendly_name='Working House', host='[::ffff:c0a8:43]', port=32237, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='host', data=('192.168.0.67', 32094)), ServiceInfo(type='mdns', data='Google-Cast-Group-d5bbe9ff0f694a2aa9e3cf15c19bbaca._googlecast._tcp.local.'), ServiceInfo(type='host', data=('[::ffff:c0a8:43]', 32094))}, uuid=UUID('d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca'), model_name='Google Cast Group', friendly_name='Full House', host='[::ffff:c0a8:43]', port=32094, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:47]:8009 (96a45d9e-0e89-5979-c40b-2399428852ee) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG pychromecast.discovery  -- Host [::ffff:c0a8:47]:32162 (05e030ca-4c83-4005-95ae-cd78cbad25f2) up, adding or updating host based service
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Home-Mini-96a45d9e0e895979c40b2399428852ee._googlecast._tcp.local.'), ServiceInfo(type='host', data=('[::ffff:c0a8:47]', 8009)), ServiceInfo(type='host', data=('192.168.0.71', 8009))}, uuid=UUID('96a45d9e-0e89-5979-c40b-2399428852ee'), model_name='Google Home Mini', friendly_name='Bunny Speaker', host='[::ffff:c0a8:47]', port=8009, cast_type='audio', manufacturer='Google Inc.')
2023-05-29 14:05:23 DEBUG music_assistant.providers.chromecast  -- Discovered new or updated chromecast CastInfo(services={ServiceInfo(type='mdns', data='Google-Cast-Group-05e030ca4c83400595aecd78cbad25f2._googlecast._tcp.local.'), ServiceInfo(type='host', data=('[::ffff:c0a8:47]', 32162)), ServiceInfo(type='host', data=('192.168.0.71', 32162))}, uuid=UUID('05e030ca-4c83-4005-95ae-cd78cbad25f2'), model_name='Google Cast Group', friendly_name='Kids', host='[::ffff:c0a8:47]', port=32162, cast_type='group', manufacturer='Google Inc.')
2023-05-29 14:06:07 WARNING asyncio  -- Executing <Task pending name='Task-150' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.303 seconds
2023-05-29 14:08:48 WARNING asyncio  -- Executing <Task pending name='Task-150' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.396 seconds
2023-05-29 14:10:22 DEBUG music_assistant.providers.sonos  -- Sonos discovery started...
2023-05-29 14:10:22 DEBUG music_assistant.providers.dlna  -- DLNA discovery started...
2023-05-29 14:11:41 WARNING asyncio  -- Executing <Task pending name='Task-150' coro=<MusicController._start_provider_sync.<locals>.run_sync() running at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:544> wait_for=<Future pending cb=[Task.task_wakeup()] created at /usr/local/lib/python3.11/asyncio/base_events.py:427> cb=[MusicAssistant.create_task.<locals>.task_done_callback() at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:293, MusicController._start_provider_sync.<locals>.on_sync_task_done() at /usr/local/lib/python3.11/site-packages/music_assistant/server/controllers/music.py:558] created at /usr/local/lib/python3.11/site-packages/music_assistant/server/server.py:286> took 0.455 seconds

Hope this helps

marcelveldt commented 1 year ago

Enabling debug logging is really not needed and causes some overhead.

When you first start the add-on, it should report what port it started, is that the normal port 8095 ?

DravenSA commented 1 year ago

yes it is port 8095 so it works when it feels like it navigated to the Music assistant open WebUI and get this Screenshot 2023-05-29 161843 then navigate a way, and come back and i get this Screenshot 2023-05-29 161720

cleared cookies, refresh browser tried chrome and firefox... same thing, 10% of the time it loads, 90% it wont.

marcelveldt commented 1 year ago

It is locking up. The eventloop or maybe even the whole machine is choking. The frontend simply doesn't load as there are no resources available.

Repeating my previous message here:

Somehow the machine was fully occupied with something, those warnings in the logs clearly indicating the eventloop suffering a lack of resources. Good that a full machine restart fixed it but when it happens again, check all your processes/add-ons what is consuming all these resources.

If its only Music Assistant that is locking up, try to remove it and reinstall. Maybe add providers one by one to detect which one is causing the lockups.

jozefKruszynski commented 1 year ago

I see that the logs indicate YouTube music is starting playlist sync. Do you happen to have any particularly large playlists, like hundreds or thousands of tracks large?

DravenSA commented 1 year ago

I have 10 playlists, from 11 songs to 176 songs, totaling 712 songs altogether but if is is syncing every time Music assistant starts up, them maybe there should be a way for it not to sync, but just check the sync and look for changes? then it would be faster and use less resources?

MarvinSchenkel commented 1 year ago

It only syncs when things have changed. Your library does not seem overly complicated. Try what Marcel suggested, do a full clean reinstall and start adding providers one by one and see if you can find something in the logs.

jozefKruszynski commented 1 year ago

These probably shouldn't cause any issue, was just wanting to rule out any edge cases. I have a playlist in tidal that is around 4000 tracks and I had to make some changes to the tidal provider with Marcel's help in order to make sure that such absurdly large playlists could be handled well.

DravenSA commented 1 year ago

It only syncs when things have changed. Your library does not seem overly complicated. Try what Marcel suggested, do a full clean reinstall and start adding providers one by one and see if you can find something in the logs.

I only have 2 providers Youtube and plex

Plex was added, and when that was done, I added Youtube

MarvinSchenkel commented 1 year ago

Please try:

DravenSA commented 1 year ago
  1. Installed MA
  2. Restarted HA
  3. Installed MA
  4. Started MA
  5. UI is unresponsive
  6. logs below

Cant believe that on i5 16gb ram and 240gb ssd is the problem, this Dell is way over powered for HA, and it has only HA OS on it, so its not in a docker running other resources. 

2023-05-30 11:23:46 INFO  music_assistant  -- Starting Music Assistant Server (6934e9c6d4d14b6fb7ccf62cef260832) - autodetected IP-address: 192.168.0.39
2023-05-30 11:23:46 INFO  music_assistant.web  -- Starting webserver on port 8095
2023-05-30 11:23:47 INFO  music_assistant.streams  -- Started stream controller (using ffmpeg version 4.3.6 with libsoxr support)
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded player provider SONOS
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded metadata provider TheAudioDB Metadata provider
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded metadata provider MusicBrainz Metadata provider
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded plugin provider Websocket API
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded player provider UPnP/DLNA Player provider
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded music provider URL
2023-05-30 11:23:49 INFO  music_assistant.providers.lms_cli  -- Registering jsonrpc endpoints on the webserver
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded metadata provider fanart.tv Metadata provider
2023-05-30 11:23:49 INFO  music_assistant.providers.lms_cli  -- Starting (telnet) CLI on port 9090
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded player provider Chromecast
2023-05-30 11:23:49 INFO  music_assistant  -- Loaded plugin provider LMS CLI
2023-05-30 11:23:49 INFO  music_assistant.players  -- Player registered: 474bed6d-b916-0f5a-cac8-050371bb14f8/Android TV
2023-05-30 11:23:49 INFO  music_assistant.players  -- Player registered: 6d50cf81-c324-69bf-bef2-c140549b5d73/Lounge speaker
2023-05-30 11:23:49 INFO  music_assistant.players  -- Player registered: d516bd4f-ef28-f9da-3074-69235aa8c9c0/Bedroom Speaker
2023-05-30 11:23:49 INFO  music_assistant.players  -- Player registered: 51a22972-195f-b3ac-0e7e-55ae6d0f6021/Office speaker
2023-05-30 11:23:50 INFO  music_assistant.providers.slimproto  -- Starting SLIMProto server on port 3483
2023-05-30 11:23:50 INFO  music_assistant  -- Loaded player provider Slimproto
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: b448786b-ee21-2e5a-8b80-4fcfcf83b5e5/Bedroom TV
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: 88dfb459-3b47-0e07-272e-e8693906aa57/Garage speaker
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: dc21c3e7-63de-850e-ca2e-b250a15de0c6/Kitchen speaker
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: 02461001-8826-4cf8-a211-6571f1977636/Morning
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: 4cf1d020-fd07-4ed0-8f3a-9446b57962fc/Working
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: a70c9d04-0dbf-40de-9b38-df309f860cb3/Working House
2023-05-30 11:23:50 INFO  music_assistant.players  -- Player registered: d5bbe9ff-0f69-4a2a-a9e3-cf15c19bbaca/Full House
2023-05-30 11:23:51 ERROR pychromecast.socket_client  -- [Full House(192.168.0.67):32094] Exception caught while sending message to controller MultizoneController: Message urn:x-cast:com.google.cast.multizone from receiver-0 to sender-0: {'requestId': 1, 'status': {'devices': [{'capabilities': 196612, 'deviceId': 'dc21c3e7-63de-850e-ca2e-b250a15de0c6', 'name': 'Kitchen speaker', 'volume': {'level': 0.4000000059604645, 'muted': False}}, {'capabilities': 196612, 'deviceId': 'd516bd4f-ef28-f9da-3074-69235aa8c9c0', 'name': 'Bedroom Speaker', 'volume': {'level': 0.10000000149011612, 'muted': False}}, {'capabilities': 196612, 'deviceId': '6d50cf81-c324-69bf-bef2-c140549b5d73', 'name': 'Lounge speaker', 'volume': {'level': 0.4000000059604645, 'muted': False}}, {'capabilities': 196612, 'deviceId': 'bcc59d8b-a0e7-c785-1c5d-3287c0d8f940', 'name': 'Red Room Speaker', 'volume': {'level': 0.5, 'muted': False}}, {'capabilities': 196612, 'deviceId': '51a22972-195f-b3ac-0e7e-55ae6d0f6021', 'name': 'Office speaker', 'volume': {'level': 0.30000001192092896, 'muted': False}}, {'capabilities': 196612, 'deviceId': '96a45d9e-0e89-5979-c40b-2399428852ee', 'name': 'Bunny Speaker', 'volume': {'level': 0.6000000238418579, 'muted': False}}], 'isMultichannel': False}, 'type': 'MULTIZONE_STATUS'}
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/pychromecast/socket_client.py", line 719, in _route_message
    handled = handler.receive_message(message, data)
              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 285, in receive_message
    self._add_member(uuid, members[uuid])
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 209, in _add_member
    listener.multizone_member_added(uuid)
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 81, in multizone_member_added
    listener.added_to_multizone(self._group_uuid)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 173, in added_to_multizone
    self.new_cast_status(self.castplayer.cc.status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 154, in new_cast_status
    self.prov.on_new_cast_status(self.castplayer, status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/__init__.py", line 394, in on_new_cast_status
    status.app_id,
    ^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'app_id'
2023-05-30 11:23:51 INFO  music_assistant.players  -- Player registered: 96a45d9e-0e89-5979-c40b-2399428852ee/Bunny Speaker
2023-05-30 11:23:51 ERROR pychromecast.controllers  -- Exception thrown when calling cast status listener
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/receiver.py", line 242, in _report_status
    listener.new_cast_status(self.status)
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 52, in new_cast_status
    listener.multizone_new_cast_status(self._group_uuid, cast_status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 198, in multizone_new_cast_status
    self.new_cast_status(self.castplayer.cc.status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 154, in new_cast_status
    self.prov.on_new_cast_status(self.castplayer, status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/__init__.py", line 394, in on_new_cast_status
    status.app_id,
    ^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'app_id'
2023-05-30 11:23:51 INFO  music_assistant.players  -- Player registered: 05e030ca-4c83-4005-95ae-cd78cbad25f2/Kids
2023-05-30 11:23:51 INFO  music_assistant  -- Loaded player provider Airplay
2023-05-30 11:23:51 ERROR pychromecast.socket_client  -- [Kids(192.168.0.71):32162] Exception caught while sending message to controller MultizoneController: Message urn:x-cast:com.google.cast.multizone from receiver-0 to sender-0: {'requestId': 1, 'status': {'devices': [{'capabilities': 196612, 'deviceId': '96a45d9e-0e89-5979-c40b-2399428852ee', 'name': 'Bunny Speaker', 'volume': {'level': 0.6000000238418579, 'muted': False}}, {'capabilities': 196612, 'deviceId': 'bcc59d8b-a0e7-c785-1c5d-3287c0d8f940', 'name': 'Red Room Speaker', 'volume': {'level': 0.5, 'muted': False}}], 'isMultichannel': False}, 'type': 'MULTIZONE_STATUS'}
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/pychromecast/socket_client.py", line 719, in _route_message
    handled = handler.receive_message(message, data)
              ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 285, in receive_message
    self._add_member(uuid, members[uuid])
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 209, in _add_member
    listener.multizone_member_added(uuid)
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 81, in multizone_member_added
    listener.added_to_multizone(self._group_uuid)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 173, in added_to_multizone
    self.new_cast_status(self.castplayer.cc.status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 154, in new_cast_status
    self.prov.on_new_cast_status(self.castplayer, status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/__init__.py", line 394, in on_new_cast_status
    status.app_id,
    ^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'app_id'
2023-05-30 11:23:51 ERROR pychromecast.controllers  -- Exception thrown when calling cast status listener
Traceback (most recent call last):
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/receiver.py", line 242, in _report_status
    listener.new_cast_status(self.status)
  File "/usr/local/lib/python3.11/site-packages/pychromecast/controllers/multizone.py", line 52, in new_cast_status
    listener.multizone_new_cast_status(self._group_uuid, cast_status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 198, in multizone_new_cast_status
    self.new_cast_status(self.castplayer.cc.status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/helpers.py", line 154, in new_cast_status
    self.prov.on_new_cast_status(self.castplayer, status)
  File "/usr/local/lib/python3.11/site-packages/music_assistant/server/providers/chromecast/__init__.py", line 394, in on_new_cast_status
    status.app_id,
    ^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'app_id'
2023-05-30 11:23:52 WARNING asyncio  -- Executing <Task finished name='Task-2' coro=<run.<locals>.new_coro() done, defined at /usr/local/lib/python3.11/site-packages/aiorun.py:227> result=None> took 0.813 seconds
2023-05-30 11:23:52 INFO  music_assistant.players  -- Player registered: bcc59d8b-a0e7-c785-1c5d-3287c0d8f940/Red Room Speaker
marcelveldt commented 1 year ago

Looks like something in Chromecast provider is choking up. If the UI comes back at any time, would you be able to temporary disable the Chromecast provider ?

DravenSA commented 1 year ago

And how do i do that?

marcelveldt commented 1 year ago

Well, wait until the UI does actually work I'm afraid... And then go to settings and disable the Chromecast provider

DravenSA commented 1 year ago

Ok i have done all that, and restated HA, UI is still unresponsive.... Unfortunately this is just not working for me, and i feel we are running in circle for a beta version. I think it is time to hang this one up and i will just remove the MA, Everything else works perfectly without MA installed, but i have noticed that other things are not loading like Studio Code and Terminal, but they work perfect when MA is not installed, so clearly MA is bottlenecking something that the logs are just not showing.

Thanks for trying, but i cant anymore, i have other things to worry about IRL.