Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Playlists not starting properly #1624

Closed
OzGav opened this issue Nov 10, 2023 Discussed in #1621 · 2 comments
Closed

Playlists not starting properly #1624

OzGav opened this issue Nov 10, 2023 Discussed in #1621 · 2 comments
Labels
bug Something isn't working

Comments

@OzGav
Copy link
Contributor

OzGav commented Nov 10, 2023

Discussed in https://github.com/orgs/music-assistant/discussions/1621

Originally posted by krisnoble November 10, 2023
Not 100% sure if this is an issue with my MA or just a quirk of my setup, but since b74 my playlists have not been starting properly so wondering if anyone can replicate?

My setup is:

  • RPi 3a's running HifiberryOS
  • HAOS + MA addon
  • Players grouped in a UGP but in this case targeting single players
  • All media and playlists stored in the /media directory

What seems to be happening is the playlists load, but don't actually play - they need the play button pressing manually either in HA or MA UI. This happens both when triggering via HA or via the blue play button in the MA UI.

If I run the command again when the player is in the stuck state, it works. So I'm working around it for now in HA by adding a second command after a 1s delay which seems to work reliably. Weirdly, running a "play" command after 1s in the same script/automation doesn't work although running the same play command manually does work, I can't figure out why.

Not seeing anything in the logs set at INFO globally, for the music controller and the queues controller.

@OzGav OzGav added the bug Something isn't working label Nov 10, 2023
@krisnoble
Copy link

Speculating but looking at the changelog I wonder if the debouncing might be the culprit here? Would make sense if the play command is being sent soon after another, and it's being incorrectly filtered out as a bounce? Sadly I'm not going to be able to look at this again until after next week but figured it was worth floating the idea...

DEBUG level logs from playing a queue then trying to play a new playlist:

2023-11-10 11:04:56.095 DEBUG (MainThread) [music_assistant.streams] Start serving audio stream for QueueItem filesystem_local://track/Deep House/The Anjunadeep Edition/325 - James Grant.mp3 to Lounge
2023-11-10 11:04:56.116 DEBUG (MainThread) [music_assistant.music.artist] updated Tagavaka in database: 638
2023-11-10 11:04:56.133 INFO (MainThread) [music_assistant.metadata] Unable to get musicbrainz ID for artist James Grant
 - using lookup-album(s): none
 - using lookup-track(s): Episode 325/Episode 345/Episode 360/Episode 384/Episode 325/Episode 345/Episode 360/Episode 384

2023-11-10 11:04:56.135 DEBUG (MainThread) [music_assistant.audio] start media stream for: filesystem_local://track/Deep House/The Anjunadeep Edition/325 - James Grant.mp3
2023-11-10 11:04:56.136 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/638
2023-11-10 11:04:56.148 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/638
2023-11-10 11:04:56.178 DEBUG (MainThread) [music_assistant.music.artist] updated James Grant in database: 32
2023-11-10 11:04:56.181 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/32
2023-11-10 11:04:56.188 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/32
2023-11-10 11:04:56.718 DEBUG (MainThread) [music_assistant.event] queue_updated b8:27:eb:0b:5c:03
2023-11-10 11:04:56.719 DEBUG (MainThread) [music_assistant.event] player_updated b8:27:eb:0b:5c:03
2023-11-10 11:04:56.734 DEBUG (MainThread) [music_assistant.webserver] [140696057703760] Handling command music/item_by_uri
2023-11-10 11:04:56.846 INFO (MainThread) [music_assistant.metadata] Unable to get musicbrainz ID for artist Tagavaka
 - using lookup-album(s): The Anjunadeep Edition/The Anjunadeep Edition
 - using lookup-track(s): Episode 467/Episode 467

2023-11-10 11:04:56.913 INFO (MainThread) [music_assistant.metadata] Unable to get musicbrainz ID for artist James Grant
 - using lookup-album(s): none
 - using lookup-track(s): Episode 325/Episode 345/Episode 360/Episode 384/Episode 325/Episode 345/Episode 360/Episode 384

2023-11-10 11:04:56.915 DEBUG (MainThread) [music_assistant.music.artist] updated Tagavaka in database: 638
2023-11-10 11:04:56.923 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/638
2023-11-10 11:04:56.935 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/638
2023-11-10 11:04:56.979 DEBUG (MainThread) [music_assistant.music.artist] updated James Grant in database: 32
2023-11-10 11:04:56.985 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/32
2023-11-10 11:04:56.992 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/32
2023-11-10 11:04:57.126 DEBUG (MainThread) [music_assistant.webserver] [140696057703760] Handling command music/playlists/library_items
2023-11-10 11:04:57.163 DEBUG (MainThread) [music_assistant] Provider file is not available
2023-11-10 11:04:57.168 DEBUG (MainThread) [music_assistant] Provider file is not available
2023-11-10 11:04:59.607 INFO (MainThread) [music_assistant.metadata] Unable to get musicbrainz ID for artist Afroham, Pleij
 - using lookup-album(s): none
 - using lookup-track(s): Birds/Birds

2023-11-10 11:04:59.648 DEBUG (MainThread) [music_assistant.music.artist] updated Afroham, Pleij in database: 644
2023-11-10 11:04:59.656 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/644
2023-11-10 11:04:59.668 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/644
2023-11-10 11:05:01.093 DEBUG (MainThread) [music_assistant.webserver] [140696057703760] Handling command music/playlists/get_playlist
2023-11-10 11:05:01.130 DEBUG (MainThread) [music_assistant.webserver] [140696057703760] Handling command music/playlists/playlist_tracks
2023-11-10 11:05:04.650 DEBUG (MainThread) [music_assistant.webserver] [140696057703760] Handling command players/queue/play_media
2023-11-10 11:05:04.653 DEBUG (MainThread) [music_assistant.event] queue_items_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.654 DEBUG (MainThread) [music_assistant.event] queue_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.656 DEBUG (MainThread) [music_assistant.players] Handling command cmd_stop for player Lounge
2023-11-10 11:05:04.692 DEBUG (MainThread) [music_assistant.event] queue_items_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.694 DEBUG (MainThread) [music_assistant.event] queue_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.713 DEBUG (MainThread) [music_assistant.event] queue_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.716 DEBUG (MainThread) [music_assistant.event] player_updated b8:27:eb:0b:5c:03
2023-11-10 11:05:04.774 DEBUG (MainThread) [music_assistant.streams] Got GET request to /b8:27:eb:0b:5c:03/single/6c5a2c723d87411cb407d5dd75c33e6c.flac from 192.168.0.139
headers: <CIMultiDictProxy('Host': '192.168.0.102:8096', 'Connection': 'close', 'Accept': '*/*', 'Cache-Control': 'no-cache', 'User-Agent': 'VLC/3.0.9 LibVLC/3.0.9', 'Range': 'bytes=0-')>

2023-11-10 11:05:04.858 DEBUG (MainThread) [music_assistant.streams] Start serving audio stream for QueueItem filesystem_local://track/Funk mixes/21 Disco Funkin', Vol. 1 (Shaka Loves You Continuous Mix).mp3 to Lounge
2023-11-10 11:05:04.893 INFO (MainThread) [music_assistant.metadata] Unable to get musicbrainz ID for artist Shaka Loves You
 - using lookup-album(s): Disco Funkin', Vol. 1 (Curated by Shaka Loves You)/Disco Funkin', Vol. 1 (Curated by Shaka Loves You)
 - using lookup-track(s): Disco Funkin', Vol. 1/Disco Funkin', Vol. 1

2023-11-10 11:05:04.895 DEBUG (MainThread) [music_assistant.audio] start media stream for: filesystem_local://track/Funk mixes/21 Disco Funkin', Vol. 1 (Shaka Loves You Continuous Mix).mp3
2023-11-10 11:05:04.967 DEBUG (MainThread) [music_assistant.music.artist] updated Shaka Loves You in database: 4
2023-11-10 11:05:04.979 DEBUG (MainThread) [music_assistant.event] media_item_updated library://artist/4
2023-11-10 11:05:04.992 DEBUG (MainThread) [music_assistant.event] media_item_added library://artist/4

@marcelveldt marcelveldt moved this from next to In progress in Music Assistant (V2) backlog Nov 12, 2023
@marcelveldt marcelveldt moved this from In progress to Done in Music Assistant (V2) backlog Nov 12, 2023
@OzGav
Copy link
Contributor Author

OzGav commented Nov 13, 2023

This should be fixed in beta 75. Let us know if not.

@OzGav OzGav closed this as completed Nov 13, 2023
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
Archived in project
Development

No branches or pull requests

2 participants