Playlist reload don't update Autocue values?

[LordHelmchen666]

I am downloading syndicated news every hour at xx:53. Because the duration of the track every hour is different i reload the playlist to calculate the "new" autocue values short before playout with

 # Reload the news playlist shortly before playing, to get latest news and not old ones from queue
thread.when(predicate.activates({ 58m00s }), fun() -> playlist_nachrichten.reload())

The values are calculated correct, but on playout LS uses "old" values. That happens when the news track are added to queue before the new one is downloaded. Any idea how can i get LS to take the new values?

# NEWS added to queue
2024/12/10 15:50:18 [azuracast.api:3] API nextsong - Response (200): {"uri":"annotate:title=\"Nachrichten\",artist=\"laut.fm\",duration=\"154.49\",song_id=\"fa23154f3d9f99ac868a7e4ddeae2e47\",media_id=\"6880\",sq_id=\"1096928\",playlist_id=\"15\":media:Syndication/lautfm-news.mp3"}
Certificate[2] subject=/C=US/O=Internet Security Research Group/CN=ISRG Root X1
Certificate[2] issuer =/C=US/O=Internet Security Research Group/CN=ISRG Root X1
Certificate[1] subject=/C=US/O=Let's Encrypt/CN=R11
Certificate[1] issuer =/C=US/O=Internet Security Research Group/CN=ISRG Root X1
Certificate[0] subject=/CN=*.stream.laut.fm
Certificate[0] issuer =/C=US/O=Let's Encrypt/CN=R11
2024/12/10 15:50:18 [autocue.cue_file:3] Now autocueing: "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3"
2024/12/10 15:50:18 [autocue.cue_file:3] Blank (silence) skipping active: false, set to 0.0 s
2024/12/10 15:50:18 [autocue.cue_file:3] Clipping prevention active: true
2024/12/10 15:50:18 [autocue.cue_file:3] Writing tags: false, including ReplayGain: false
2024/12/10 15:50:18 [autocue.cue_file:3] Writing metadata to /var/azuracast/stations/laut.fm_eisradio/temp/cue_file4f943e.json
2024/12/10 15:50:18 [azuracast.api:3] API feedback - Response (200): true
2024/12/10 15:50:18 [autocue.cue_file:3] cue_file result for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {"duration": 154.488163, "cue_file_cue_duration": 154.423313, "cue_file_cue_in": 0.1, "cue_file_cue_out": 154.523313, "cue_file_cross_start_next": 154.523313, "cue_file_longtail": false, "cue_file_sustained_ending": true, "cue_file_loudness": "-12.41 LUFS", "cue_file_loudness_range": "3.29 LU", "cue_file_amplify": "-5.59 dB", "cue_file_amplify_adjustment": "0.00 dB", "cue_file_reference_loudness": "-18.00 LUFS", "cue_file_blankskip": 0.0, "cue_file_blank_skipped": false, "cue_file_true_peak": 0.991, "cue_file_true_peak_db": "-0.08 dBFS"}
2024/12/10 15:50:18 [autocue.cue_file:3] Clipping prevention: Adjusted calculated replaygain_track_gain from -5.59 dB to -5.59 dB
2024/12/10 15:50:18 [autocue.cue_file:2] Given fade-out duration (0.1 s) exceeds available time, using 0.0 s.
2024/12/10 15:50:18 [autocue.cue_file:3] Metadata added/corrected for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3":
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_amplify", "-5.59 dB")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_amplify_adjustment", "0.00 dB")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_blank_skipped", "false")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_blankskip", "0.00")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_cross_start_next", "154.523313")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_cue_duration", "154.42")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_cue_in", "0.1")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_cue_out", "154.523313")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_fade_in", "0.1")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_fade_out", "0.0")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_longtail", "false")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_loudness", "-12.41 LUFS")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_loudness_range", "3.29 LU")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_reference_loudness", "-18.00 LUFS")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_sustained_ending", "true")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_true_peak", "0.991000")
2024/12/10 15:50:18 [autocue.cue_file:3] ("cue_file_true_peak_db", "-0.08 dBFS")
2024/12/10 15:50:18 [autocue.cue_file:3] ("duration", "154.488163")
2024/12/10 15:50:18 [autocue.cue_file:3] ("replaygain_reference_loudness", "-18.00 LUFS")
2024/12/10 15:50:18 [autocue.cue_file:3] ("replaygain_track_gain", "-5.59 dB")
2024/12/10 15:50:18 [decoder.ffmpeg:3] Requested content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}
2024/12/10 15:50:18 [decoder.ffmpeg:3] FFmpeg recognizes "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3" as audio: {codec: mp3, 44100Hz, 2 channel(s)}
2024/12/10 15:50:18 [decoder.ffmpeg:3] Decoded content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}
2024/12/10 15:50:20 [cross.buffer.136:3] Content type is {audio=pcm(stereo)}.

# Reloading Playlist
2024/12/10 15:58:00 [playlist_nachrichten:3] Reloading playlist with URI /var/azuracast/stations/laut.fm_eisradio/playlists/playlist_nachrichten.m3u.
2024/12/10 15:58:00 [autocue.cue_file:3] Now autocueing: "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3"
2024/12/10 15:58:00 [autocue.cue_file:3] Blank (silence) skipping active: false, set to 0.0 s
2024/12/10 15:58:00 [autocue.cue_file:3] Clipping prevention active: true
2024/12/10 15:58:00 [autocue.cue_file:3] Writing tags: false, including ReplayGain: false
2024/12/10 15:58:00 [autocue.cue_file:3] Writing metadata to /var/azuracast/stations/laut.fm_eisradio/temp/cue_file15f420.json
2024/12/10 15:58:00 [autocue.cue_file:3] cue_file result for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {"duration": 171.702857, "cue_file_cue_duration": 171.638, "cue_file_cue_in": 0.1, "cue_file_cue_out": 171.738, "cue_file_cross_start_next": 171.738, "cue_file_longtail": false, "cue_file_sustained_ending": true, "cue_file_loudness": "-12.46 LUFS", "cue_file_loudness_range": "5.78 LU", "cue_file_amplify": "-5.54 dB", "cue_file_amplify_adjustment": "0.00 dB", "cue_file_reference_loudness": "-18.00 LUFS", "cue_file_blankskip": 0.0, "cue_file_blank_skipped": false, "cue_file_true_peak": 1.037, "cue_file_true_peak_db": "0.32 dBFS"}
2024/12/10 15:58:00 [autocue.cue_file:3] Clipping prevention: Adjusted calculated replaygain_track_gain from -5.54 dB to -5.54 dB
2024/12/10 15:58:00 [autocue.cue_file:2] Given fade-out duration (0.1 s) exceeds available time, using 0.0 s.
2024/12/10 15:58:00 [autocue.cue_file:3] Metadata added/corrected for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3":
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_amplify", "-5.54 dB")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_amplify_adjustment", "0.00 dB")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_blank_skipped", "false")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_blankskip", "0.00")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_cross_start_next", "171.738")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_cue_duration", "171.64")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_cue_in", "0.1")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_cue_out", "171.738")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_fade_in", "0.1")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_fade_out", "0.0")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_longtail", "false")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_loudness", "-12.46 LUFS")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_loudness_range", "5.78 LU")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_reference_loudness", "-18.00 LUFS")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_sustained_ending", "true")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_true_peak", "1.037000")
2024/12/10 15:58:00 [autocue.cue_file:3] ("cue_file_true_peak_db", "0.32 dBFS")
2024/12/10 15:58:00 [autocue.cue_file:3] ("duration", "171.702857")
2024/12/10 15:58:00 [autocue.cue_file:3] ("replaygain_reference_loudness", "-18.00 LUFS")
2024/12/10 15:58:00 [autocue.cue_file:3] ("replaygain_track_gain", "-5.54 dB")
2024/12/10 15:58:00 [decoder.ffmpeg:3] Requested content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}
2024/12/10 15:58:00 [decoder.ffmpeg:3] FFmpeg recognizes "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3" as audio: {codec: mp3, 44100Hz, 2 channel(s)}
2024/12/10 15:58:00 [decoder.ffmpeg:3] Decoded content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}

# Playout News
2024/12/10 15:58:55 [next_song:3] Prepared "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3" (RID 162).
2024/12/10 15:58:55 [request.162:3] End of track reached at 0.10 before cue-out point at 154.52!
2024/12/10 15:58:55 [log_meta:3] ("duration", "154.49")
2024/12/10 15:58:55 [log_meta:3] ("liq_amplify", "-5.59 dB")
2024/12/10 15:58:55 [log_meta:3] ("liq_autocue", "cue_file")
2024/12/10 15:58:55 [log_meta:3] ("liq_cross_end_duration", "0.0")
2024/12/10 15:58:55 [log_meta:3] ("liq_cross_max_start_duration", "154.423313")
2024/12/10 15:58:55 [log_meta:3] ("liq_cross_start_duration", "0.1")
2024/12/10 15:58:55 [log_meta:3] ("liq_cue_in", "0.1")
2024/12/10 15:58:55 [log_meta:3] ("liq_cue_out", "154.523313")
2024/12/10 15:58:55 [log_meta:3] ("liq_fade_in", "0.1")
2024/12/10 15:58:55 [log_meta:3] ("liq_fade_out", "0.0")
2024/12/10 15:58:55 [log_meta:3] ("liq_fade_out_delay", "0.0")
2024/12/10 15:58:55 [log_meta:3] ("liq_fade_out_start_next", "0.0")
2024/12/10 15:58:55 [log_meta:3] ("media_id", "6880")
2024/12/10 15:58:55 [log_meta:3] ("replaygain_reference_loudness", "-18.00 LUFS")
2024/12/10 15:58:55 [log_meta:3] ("replaygain_track_gain", "-5.59 dB")
2024/12/10 15:58:55 [log_meta:3] Now playing: laut.fm - Nachrichten
2024/12/10 15:58:55 [azuracast.api:3] API nextsong - Sending POST request to 'http://127.0.0.1:6010/api/internal/3/liquidsoap/nextsong' with body: 
2024/12/10 15:58:55 [cross:3] Analysis: -33.039476dB / -18.941375dB (1.78s / 1.78s)

[gAlleb]

Hi! I'm not sure that it can work this way. I see that you reload a playlist but you feed it to playout through Next Song API. And I think the problem is connected with this.

Or simply when news added to queue they are already cached by LS. When you reload a playlist - this has no impact because you use API (not playlist). Hence you get same values. Because LS gets a song not from a playlist but from API (and those values are old).

You should try handling news manually by Liquidsoap, not by Azuracast API - like here #4004 + making playlist advanced and redefining it. Maybe this would make it work.

playlist_nachrichten = playlist("/var/azuracast/stations/laut.fm_eisradio/playlists/playlist_nachrichten.m3u")

# Reload the news playlist shortly before playing,
# to get latest news and not old queued ones
thread.when(predicate.activates({ 59m45s or 29m45s }), fun() -> playlist_nachrichten.reload())

# Make a News source that is only active at certain times
# Hourly news at 06:00-18:00 and 20:00, 16s past the hour
# to leave room for the TOTH time & station announcement
news = fallback(
  track_sensitive=false,
  [
    switch(
      id="news_switch",
      [(predicate.once({ (6h00-18h00 or 20h00) and 0m16s }), playlist_nachrichten)]
    )
  ]
)
# When news source becomes active:
# Skip current track, play news, continue with new track
radio = fallback.skip(news, fallback=radio)

What you are doing in you first post is basically:

1. News are queued by Next Song API at 50 min. Duration is 154 sec.
2. You reload a playlist with new values. But it doesn't matter because you don't use this playlist and use Next Song API instead.
3. At 58 min you play a file that has been calculated at 50 min. Duration is 154 sec.

[gAlleb]

Yeah, out of curiosity tried it out now. Works fine.

[LordHelmchen666]

Hm. Must be in a special order? Before cross or requests or so? I see it in the logs, but do not hear it on the stream. Even after ten minutes listening.

2024/12/12 17:58:00 [autocue.cue_file:3] Now autocueing: "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3"
2024/12/12 17:58:00 [autocue.cue_file:3] Blank (silence) skipping active: false, set to 0.0 s
2024/12/12 17:58:00 [autocue.cue_file:3] Clipping prevention active: true
2024/12/12 17:58:00 [autocue.cue_file:3] Writing tags: false, including ReplayGain: false
2024/12/12 17:58:00 [autocue.cue_file:3] Writing metadata to /var/azuracast/stations/laut.fm_eisradio/temp/cue_file82969f.json
2024/12/12 17:58:00 [autocue.cue_file:3] cue_file result for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {"duration": 171.62449, "cue_file_cue_duration": 171.559688, "cue_file_cue_in": 0.1, "cue_file_cue_out": 171.659688, "cue_file_cross_start_next": 171.659688, "cue_file_longtail": false, "cue_file_sustained_ending": true, "cue_file_loudness": "-12.54 LUFS", "cue_file_loudness_range": "4.17 LU", "cue_file_amplify": "-5.46 dB", "cue_file_amplify_adjustment": "0.00 dB", "cue_file_reference_loudness": "-18.00 LUFS", "cue_file_blankskip": 0.0, "cue_file_blank_skipped": false, "cue_file_true_peak": 1.021, "cue_file_true_peak_db": "0.18 dBFS"}
2024/12/12 17:58:00 [autocue.cue_file:3] Clipping prevention: Adjusted calculated replaygain_track_gain from -5.46 dB to -5.46 dB
2024/12/12 17:58:00 [autocue.cue_file:2] Given fade-out duration (0.1 s) exceeds available time, using 0.0 s.
2024/12/12 17:58:00 [autocue.cue_file:3] Metadata added/corrected for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3":
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_amplify", "-5.46 dB")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_amplify_adjustment", "0.00 dB")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_blank_skipped", "false")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_blankskip", "0.00")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_cross_start_next", "171.659688")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_cue_duration", "171.56")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_cue_in", "0.1")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_cue_out", "171.659688")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_fade_in", "0.1")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_fade_out", "0.0")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_longtail", "false")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_loudness", "-12.54 LUFS")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_loudness_range", "4.17 LU")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_reference_loudness", "-18.00 LUFS")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_sustained_ending", "true")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_true_peak", "1.021000")
2024/12/12 17:58:00 [autocue.cue_file:3] ("cue_file_true_peak_db", "0.18 dBFS")
2024/12/12 17:58:00 [autocue.cue_file:3] ("duration", "171.62449")
2024/12/12 17:58:00 [autocue.cue_file:3] ("replaygain_reference_loudness", "-18.00 LUFS")
2024/12/12 17:58:00 [autocue.cue_file:3] ("replaygain_track_gain", "-5.46 dB")
2024/12/12 17:58:00 [decoder.ffmpeg:3] Requested content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}
2024/12/12 17:58:00 [decoder.ffmpeg:3] FFmpeg recognizes "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3" as audio: {codec: mp3, 44100Hz, 2 channel(s)}
2024/12/12 17:58:00 [decoder.ffmpeg:3] Decoded content-type for "/var/azuracast/stations/eisradio/media/Syndication/lautfm-news.mp3": {audio=pcm(stereo)}
2024/12/12 17:58:00 [lang:3] Pushed news to queue

[gAlleb]

Just as usual in the 3rd box.
Well, 58m - time when track is pushed into the queue. This queue is track sensitive so will play when the current track finishes.
Not sure what can be wrong. Everything is straightforward. Works fine on my instance.

[LordHelmchen666]

That's it. I had in fourth box. Now in third box it runs fine! Could it really be the cause? Doesn't matter. :) 👍

[gAlleb]

nice!