search

savonet / liquidsoap

Liquidsoap is a statically typed scripting general-purpose language with dedicated operators and backend for all thing media, streaming, file generation, automation, HTTP backend and more.
http://liquidsoap.info
GNU General Public License v2.0
1.39k stars 128 forks source link

2022/04/06 20:40:10 [output.file_0:3] Source failed (no more tracks) stopping output... #2327

Open Marcioghiraldelli opened 2 years ago

Marcioghiraldelli commented 2 years ago

I'm using azuracast with liquidsoap 2.0.4 and I've been having frequent problems with the radio turning off, staying for a few minutes and playing again.

the log below

2022/04/06 20:40:10 >>> LOG START
2022/04/06 20:40:04 [main:3] Liquidsoap 2.0.4
2022/04/06 20:40:04 [main:3] Using: bytes=[distributed with OCaml 4.02 or above] pcre=7.5.0 sedlex=2.6 menhirLib=20211128 curl=0.9.2 dtools=0.4.4 duppy=0.9.2 cry=0.6.6 mm=bfff160 ogg=0.7.1 ogg.decoder=0.7.1 vorbis=0.8.0 vorbis.decoder=0.8.0 opus=0.2.1 opus.decoder=0.2.1 mad=0.5.2 flac=0.3.0 flac.ogg=0.3.0 flac.decoder=0.3.0 dynlink=[distributed with Ocaml] lame=0.3.5 frei0r=0.1.2 fdkaac=0.3.2 ffmpeg=1.1.2 samplerate=0.1.6 taglib=0.3.9 ssl=0.5.9 camomile=1.0.2 faad=0.5.0 ladspa=0.2.2
2022/04/06 20:40:07 [clock:3] Using builtin (low-precision) implementation for latency control
2022/04/06 20:40:10 [lang.deprecated:2] WARNING: "map_metadata" is deprecated and will be removed in future version. Please use "metadata.map" instead.
2022/04/06 20:40:10 [lang.deprecated:2] WARNING: "map_metadata" is deprecated and will be removed in future version. Please use "metadata.map" instead.
2022/04/06 20:40:10 [frame:3] Using 44100Hz audio, 25Hz video, 44100Hz main.
2022/04/06 20:40:10 [frame:3] Video frame size set to: 1280x720
2022/04/06 20:40:10 [frame:3] Frame size must be a multiple of 1764 ticks = 1764 audio samples = 1 video samples.
2022/04/06 20:40:10 [frame:3] Targeting 'frame.duration': 0.04s = 1764 audio samples = 1764 ticks.
2022/04/06 20:40:10 [frame:3] Frames last 0.04s = 1764 audio samples = 1 video samples = 1764 ticks.
2022/04/06 20:40:10 [sandbox:3] Running inside a docker container, disabling sandboxing.
2022/04/06 20:40:10 [video.converter:3] Using preferred video converter: ffmpeg.
2022/04/06 20:40:10 [audio.converter:3] Using samplerate converter: ffmpeg.
2022/04/06 20:40:10 [harbor:3] Adding mountpoint '/' on port 8195
2022/04/06 20:40:10 [error_jingle:3] /usr/local/share/icecast/web/error.mp3 is static, resolving once for all...
2022/04/06 20:40:10 [error_jingle:3] Prepared "/usr/local/share/icecast/web/error.mp3" (RID 5).
2022/04/06 20:40:10 [local_1:3] Connecting mount sid#1 for @127.0.0.1...
2022/04/06 20:40:10 [local_1:3] Connection setup was successful.
2022/04/06 20:40:10 [video.add_text:3] Using ffmpeg implementation
2022/04/06 20:40:10 [clock.main:3] Streaming loop starts in auto-sync mode
2022/04/06 20:40:10 [clock.main:3] Delegating synchronisation to CPU clock
2022/04/06 20:40:10 [output.file_0:3] Source failed (no more tracks) stopping output...
2022/04/06 20:40:10 [safe_fallback:3] Switch to error_jingle.

[mp3float @ 0x7f2b200eae40] Could not update timestamps for discarded samples.
2022/04/06 20:40:02 [decoder:2] Decoding "/var/azuracast/stations/so_modao_sertaneja/media/media/Vinhetas/10  VH2 web radio  - 604164.mp3" ended: Ffmpeg_decoder.End_of_file.
[mp3 @ 0x7f2b20203800] Format mp3 detected only with low score of 1, misdetection possible!
[mp3 @ 0x7f2b20203800] Failed to read frame size: Could not seek to 1026.
2022/04/06 20:40:02 [clock.main:2] Source local_1 failed while streaming: Avutil.Error(Invalid argument)!
2022/04/06 20:40:02 [local_1:3] Closing connection...
2022/04/06 20:40:02 [main:3] Shutdown started!
2022/04/06 20:40:02 [main:3] Waiting for main threads to terminate...
2022/04/06 20:40:03 [lang:3] API djoff - Response: true
2022/04/06 20:40:03 [harbor:3] Removing mountpoint '/' on port 8195
2022/04/06 20:40:03 [harbor:3] Nothing more on port 8195: closing sockets.
2022/04/06 20:40:03 [clock.main:3] Streaming loop stopped.
2022/04/06 20:40:03 [main:3] Main threads terminated.
2022/04/06 20:40:03 [threads:3] Shutting down scheduler...
2022/04/06 20:40:03 [threads:3] Scheduler shut down.
2022/04/06 20:40:03 [main:3] Cleaning downloaded files...
2022/04/06 20:40:03 [main:3] Freeing memory...
2022/04/06 20:40:10 >>> LOG START
2022/04/06 20:40:04 [main:3] Liquidsoap 2.0.4
2022/04/06 20:40:04 [main:3] Using: bytes=[distributed with OCaml 4.02 or above] pcre=7.5.0 sedlex=2.6 menhirLib=20211128 curl=0.9.2 dtools=0.4.4 duppy=0.9.2 cry=0.6.6 mm=bfff160 ogg=0.7.1 ogg.decoder=0.7.1 vorbis=0.8.0 vorbis.decoder=0.8.0 opus=0.2.1 opus.decoder=0.2.1 mad=0.5.2 flac=0.3.0 flac.ogg=0.3.0 flac.decoder=0.3.0 dynlink=[distributed with Ocaml] lame=0.3.5 frei0r=0.1.2 fdkaac=0.3.2 ffmpeg=1.1.2 samplerate=0.1.6 taglib=0.3.9 ssl=0.5.9 camomile=1.0.2 faad=0.5.0 ladspa=0.2.2
2022/04/06 20:40:07 [clock:3] Using builtin (low-precision) implementation for latency control
2022/04/06 20:40:10 [lang.deprecated:2] WARNING: "map_metadata" is deprecated and will be removed in future version. Please use "metadata.map" instead.
2022/04/06 20:40:10 [lang.deprecated:2] WARNING: "map_metadata" is deprecated and will be removed in future version. Please use "metadata.map" instead.
2022/04/06 20:40:10 [frame:3] Using 44100Hz audio, 25Hz video, 44100Hz main.
2022/04/06 20:40:10 [frame:3] Video frame size set to: 1280x720
2022/04/06 20:40:10 [frame:3] Frame size must be a multiple of 1764 ticks = 1764 audio samples = 1 video samples.
2022/04/06 20:40:10 [frame:3] Targeting 'frame.duration': 0.04s = 1764 audio samples = 1764 ticks.
2022/04/06 20:40:10 [frame:3] Frames last 0.04s = 1764 audio samples = 1 video samples = 1764 ticks.
2022/04/06 20:40:10 [sandbox:3] Running inside a docker container, disabling sandboxing.
2022/04/06 20:40:10 [video.converter:3] Using preferred video converter: ffmpeg.
2022/04/06 20:40:10 [audio.converter:3] Using samplerate converter: ffmpeg.
2022/04/06 20:40:10 [harbor:3] Adding mountpoint '/' on port 8195
2022/04/06 20:40:10 [error_jingle:3] /usr/local/share/icecast/web/error.mp3 is static, resolving once for all...
2022/04/06 20:40:10 [error_jingle:3] Prepared "/usr/local/share/icecast/web/error.mp3" (RID 5).
2022/04/06 20:40:10 [local_1:3] Connecting mount sid#1 for @127.0.0.1...
2022/04/06 20:40:10 [local_1:3] Connection setup was successful.
2022/04/06 20:40:10 [video.add_text:3] Using ffmpeg implementation
2022/04/06 20:40:10 [clock.main:3] Streaming loop starts in auto-sync mode
2022/04/06 20:40:10 [clock.main:3] Delegating synchronisation to CPU clock
2022/04/06 20:40:10 [output.file_0:3] Source failed (no more tracks) stopping output...
2022/04/06 20:40:10 [safe_fallback:3] Switch to error_jingle.
[mp3float @ 0x7f07c0004d40] Could not update timestamps for skipped samples.
[mp3 @ 0x7f07c4008f00] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c40119c0] Estimating duration from bitrate, this may be inaccurate
2022/04/06 20:40:10 [playlist_hora_certa:3] Prepared "/var/azuracast/stations/so_modao_sertaneja/media/hora-certa.mp3" (RID 6).
2022/04/06 20:40:10 [safe_fallback:3] Switch to compress_0 with transition.
2022/04/06 20:40:10 [live_fallback:3] Switch to crossfade_0.
[mp3float @ 0x7f07c00671c0] Could not update timestamps for skipped samples.
2022/04/06 20:40:10 [requests_fallback:3] Switch to autodj_fallback.
2022/04/06 20:40:10 [autodj_fallback:3] Switch to switch_7.
2022/04/06 20:40:10 [switch_7:3] Switch to delay_1.
2022/04/06 20:40:10 [cue_playlist_hora_certa:3] Cueing in...
2022/04/06 20:40:11 [lang:3] API nextsong - Response: annotate:title="Capa De Revista",artist="Gilberto E Gilmar",duration="184.00",song_id="9cde6e4bef220b4132f3089156ad6a1d",media_id="117757",liq_amplify="0.00dB",playlist_id="221":/var/azuracast/stations/so_modao_sertaneja/media/media/MUSICA 05/capa de revista.mp3
[mp3 @ 0x7f07c80367c0] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c80367c0] Estimating duration from bitrate, this may be inaccurate
2022/04/06 20:40:11 [decoder.id3v2:2] Error while decoding file tags: Invalid_argument("String.sub / Bytes.sub")
2022/04/06 20:40:11 [lang:3] API feedback - Response: true
[mp3 @ 0x7f07c400b500] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c400c8c0] Estimating duration from bitrate, this may be inaccurate
2022/04/06 20:40:11 [next_song:3] Prepared "/var/azuracast/stations/so_modao_sertaneja/media/media/MUSICA 05/capa de revista.mp3" (RID 9).
2022/04/06 20:40:11 [lang:3] AutoDJ is ready!
[mp3 @ 0x7f07c803bf40] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c80a8040] Estimating duration from bitrate, this may be inaccurate
2022/04/06 20:40:12 [lang:3] API nextsong - Response: annotate:title="Só Quem Amou Fui Eu",artist="João Mineiro & Marciano",duration="210.00",song_id="e90a85caf27b3313203d2ddce5b1d83c",media_id="118232",liq_amplify="0.00dB",playlist_id="221":/var/azuracast/stations/so_modao_sertaneja/media/media/MUSICA 05/so quem amou fui eu.mp3
[mp3 @ 0x7f07c40235c0] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c40129c0] Estimating duration from bitrate, this may be inaccurate
[mp3float @ 0x7f07c00671c0] Could not update timestamps for discarded samples.
2022/04/06 20:40:12 [decoder:2] Decoding "/var/azuracast/stations/so_modao_sertaneja/media/hora-certa.mp3" ended: Ffmpeg_decoder.End_of_file.
2022/04/06 20:40:13 [playlist_hora_certa:3] Prepared "/var/azuracast/stations/so_modao_sertaneja/media/hora-certa.mp3" (RID 12).
[mp3 @ 0x7f07c012df00] Estimating duration from bitrate, this may be inaccurate
[mp3 @ 0x7f07c012df00] Estimating duration from bitrate, this may be inaccurate
2022/04/06 20:40:13 [playlist_programe_te:3] Prepared "/var/azuracast/stations/so_modao_sertaneja/media/01 Programetes/47-Mensagem do Dia/Mensagem do dia (1).mp3" (RID 7).
2022/04/06 20:40:13 [switch_7:3] Switch to switch_6 with forgetful transition.
2022/04/06 20:40:13 [autodj_fallback:3] Switch to dynamic_startup with forgetful transition.
2022/04/06 20:40:13 [dynamic_startup:3] Switch to cue_next_song.
2022/04/06 20:40:13 [cue_next_song:3] Cueing in...
2022/04/06 20:40:13 [cross_0:3] Analysis: -12.401541dB / -22.863640dB (2.96s / 2.96s)
2022/04/06 20:40:13 [crossfade_0:3] No transition: using default.
2022/04/06 20:40:16 [lang:3] API feedback - Response: true
Marcioghiraldelli commented 2 years ago

I'm using azuracast with liquidsoap 2.0.4 and I've been having frequent problems with the radio turning off, staying for a few minutes and playing again.

the log below