[mythtv-users] Status of ffmpeg 4.4.1

Tue Nov 16 14:26:00 UTC 2021

On 11/15/21 8:53 PM, James Abernathy wrote:
>
>
> On Mon, Nov 15, 2021 at 8:06 PM Peter Bennett <pb.mythtv at gmail.com 
> <mailto:pb.mythtv at gmail.com>> wrote:
>
>
>     On 11/15/21 5:49 PM, James Abernathy wrote:
>     > So here was the sequence.  After testing with ffmpeg-resync with
>     the
>     > latest pull, I checked out Master again and git clean, etc. and
>     > rebuilt. On that version when I tuned to a station that only
>     broadcast
>     > in Stereo, it had the popup in the frontend with the RED X. I
>     forgot
>     > the exact message, but figured it was the same as before.
>     >
>     If you run the frontend with -v libav,audio, the error that was
>     appearing with ffmpeg-resync before I fixed it was this
>
>     2021-11-03 14:43:28.698565 E  [ac3_fixed @ 00007fb5939a5c00]
>     Specified
>     sample format s16p is invalid or not supported
>
>     It seems that s16p was no longer supported in the new ffmpeg
>     version. I
>     switched to format FLT (float) to fix it and switched to codec ac3
>     instead of ac3_fixed.
>
>     I suspect you may be getting some other error.
>
>     Peter
>
>
> So I just checked out Master and rebuilt.  I ran the frontend with the 
> verbose option you suggested.  On Screen it says the AC3 decoder 
> failed to initialize. Part of the log is below:
>
> 2021-11-15 20:47:25.465368 I  Player(0): Opening 
> '/srv/mythtv/livetv/15003_20211116014724.ts'
> 2021-11-15 20:47:26.421107 W  [mpegts @ 00007f6445e10140] PES packet 
> size mismatch
> 2021-11-15 20:47:26.421118 W  [mpegts @ 00007f6445e10140] Packet 
> corrupt (stream = 1, dts = 2229304758).
> 2021-11-15 20:47:26.421122 W  [mpegts @ 00007f6445e10140] PES packet 
> size mismatch
> 2021-11-15 20:47:26.421126 W  [mpegts @ 00007f6445e10140] Packet 
> corrupt (stream = 2, dts = 2229307638).
> 2021-11-15 20:47:26.421294 I  AFD: codec AC3 has 2 channels
> 2021-11-15 20:47:26.421401 I  AFD: Opened codec 0x5640e3b1a380, 
> id(AC3) type(Audio)
> 2021-11-15 20:47:26.421457 I  AFD: Audio Track #1, of type (Normal) is 
> A/V stream #1 (id=0x64) and has 2 channels in the English 
> language(6647399).
> 2021-11-15 20:47:26.421459 I  AFD: codec AC3 has 2 channels
> 2021-11-15 20:47:26.421558 I  AFD: Opened codec 0x5640e2ef5000, 
> id(AC3) type(Audio)
> 2021-11-15 20:47:26.421566 I  AFD: Audio Track #2, of type (Normal) is 
> A/V stream #2 (id=0x65) and has 2 channels in the Spanish; Castilian 
> language(7565409).
> 2021-11-15 20:47:26.422198 I  VideoOutput: SetDeinterlacing 
> (Doublerate 0): Single High|CPU|GLSL Double None
> 2021-11-15 20:47:26.422212 I  AFD: Using ffmpeg for video decoding
> 2021-11-15 20:47:26.422507 I  AFD: Opened codec 0x5640e398d240, 
> id(MPEG2VIDEO) type(Video)
> 2021-11-15 20:47:26.422516 I  AFD: Trying to select audio track (w/lang)
> 2021-11-15 20:47:26.423016 I  AFD: Selected track 0 (A/V Stream #1)
> 2021-11-15 20:47:26.423025 I  AFD: Audio data is planar
> 2021-11-15 20:47:26.423034 I  AFD: Initializing audio parms from audio 
> track #1
> 2021-11-15 20:47:26.423044 I  AFD: Audio format changed
> from id(NONE)     -1Hz -1ch -1bps     (profile 0) to id( AC3)  48000Hz 
>  2ch 32bps     (profile 0)
> 2021-11-15 20:47:26.423056 I  AOBase: Needs upmix from 2 -> 6 channels
> 2021-11-15 20:47:26.423059 I  AOBase: Killing AudioOutputDSP
> 2021-11-15 20:47:26.423065 I  AOBase: Original codec was AC3, 32 bit 
> floating point, 48 kHz, 2 channels
> 2021-11-15 20:47:26.423071 I  AOBase: enc(1), passthru(0), features 
> (AC3,DTS) configured_channels(6), 6 channels supported(1) max_channels(6)
> 2021-11-15 20:47:26.423072 I  AOBase: Reencoding decoded AC-3/DTS to AC-3
> 2021-11-15 20:47:26.423075 I  AOBase: Creating AC-3 Encoder with sr = 
> 48000, ch = 6
> 2021-11-15 20:47:26.423099 I  DEnc: Init codecid=AC3, br=448000, 
> sr=48000, ch=6
> 2021-11-15 20:47:26.423153 E  [ac3_fixed @ 00007f644558dd60] Specified 
> sample format s16p is invalid or not supported
> 2021-11-15 20:47:26.423158 E  DEnc: Could not open codec, invalid 
> bitrate or samplerate
> 2021-11-15 20:47:26.423164 E  AudioOutput Error: Ac-3 Encoder 
> Initialization Failed
> 2021-11-15 20:47:26.423172 I  AOBase: Audio processing enabled
> 2021-11-15 20:47:26.423176 I  AOBase: Opening audio device 
> 'hdmi:CARD=PCH,DEV=0' ch 6(2) sr 48000 sf signed 32 bit reenc 1
> 2021-11-15 20:47:26.423178 I  ALSA: OpenDevice hdmi:CARD=PCH,DEV=0
> 2021-11-15 20:47:26.476197 I  ALSA: SetParameters(format=10, 
> channels=6, rate=48000, buffer_time=500000, period_time=4)
> 2021-11-15 20:47:26.476378 I  ALSA: Buffer size range from 12 to 174762
> 2021-11-15 20:47:26.476387 I  ALSA: Period size range from 6 to 87381
> 2021-11-15 20:47:26.476435 I  ALSA: Buffer time = 500000 us
> 2021-11-15 20:47:26.476468 I  ALSA: Period time = 4 periods
> 2021-11-15 20:47:26.490564 I  ALSA: Buffer size = 24000 | Period size 
> = 6000
> 2021-11-15 20:47:26.505045 E  ALSA: no playback control PCM found on 
> mixer device default
> 2021-11-15 20:47:26.505049 E  ALSA: Unable to open audio mixer. Volume 
> control disabled
> 2021-11-15 20:47:26.505053 I  AOBase: Audio fragment size: 72000
> 2021-11-15 20:47:26.505072 I  AOBase: Audio Stretch Factor: 1
> 2021-11-15 20:47:26.505120 I  AOBase: Ending Reconfigure()
> 2021-11-15 20:47:26.505129 N  AudioPlayer: Disabling Audio, reason is: 
> Ac-3 Encoder Initialization Failed
> 2021-11-15 20:47:26.505195 I  AOBase: kickoffOutputAudioLoop: pid = 40129
> 2021-11-15 20:47:26.505250 I  AOBase: OutputAudioLoop: Play Event
> 2021-11-15 20:47:26.507179 I  Input #0, mpegts, from 
> '/srv/mythtv/livetv/15003_20211116014724.ts':
> 2021-11-15 20:47:26.507192 I  Duration: 00:00:01.50, start: 
> 24769.092867, bitrate: 1911 kb/s
> 2021-11-15 20:47:26.507282 I  Stream #0:0[0x61]: Video: mpeg2video 
> (Main), yuv420p(tv, top first), 704x480 [SAR 40:33 DAR 16:9], 1000 
> kb/s, 29.97 fps, 29.97 tbr, 90k tbn, 59.94 tbc
> 2021-11-15 20:47:26.507284 I  Side data:
> 2021-11-15 20:47:26.507292 I  cpb: bitrate max/min/avg: 3896000/0/0 
> buffer size: 1835008 vbv_delay: N/A
> 2021-11-15 20:47:26.507330 I  Stream #0:1[0x64](eng): Audio: ac3 (AC-3 
> / 0x332D4341), 48000 Hz, stereo, fltp, 192 kb/s
> 2021-11-15 20:47:26.507356 I  Stream #0:2[0x65](spa): Audio: ac3 (AC-3 
> / 0x332D4341), 48000 Hz, stereo, fltp, 128 kb/s
> 2021-11-15 20:47:26.611862 N  Player(0): Waited 101ms for video 
> buffers AAAAAAAAAAAAAuLL
> 2021-11-15 20:47:26.715939 N  Player(0): Waited 205ms for video 
> buffers ULAAAAAAAAAAAULU
> 2021-11-15 20:47:26.820135 N  Player(0): Waited 310ms for video 
> buffers ULLAAAAAAAAAAUuU
> 2021-11-15 20:47:26.924378 N  Player(0): Waited 414ms for video 
> buffers ULUULAAAAAAAAUUU
> 2021-11-15 20:47:26.976695 I  VideoOutput: SetDeinterlacing 
> (Doublerate 1): Single High|CPU|GLSL Double High|CPU|GLSL
> 2021-11-15 20:47:26.977038 I  VideoOutput: SetDeinterlacing 
> (Doublerate 1): Single High|CPU|GLSL Double High|CPU|GLSL
> 2021-11-15 20:47:26.977134 I  GLVid: New frame format: None:None 
> 704x480 (Tex: 2D) -> YUV420P:YUV420P 704x480 (Tex: 2D)
> 2021-11-15 20:47:27.161612 N  Player(0): Waited 101ms for video 
> buffers AUUUUULULAAAAAUA
> 2021-11-15 20:47:37.442561 I  TV::HandleStateChange(): Attempting to 
> change from WatchingLiveTV to None
> 2021-11-15 20:47:37.442691 I  ScreenSaverDBus: Screensaver uninhibited 
> via org.freedesktop.ScreenSaver
> 2021-11-15 20:47:37.442702 I  ScreenSaverX11: Uninhibited screensaver
> 2021-11-15 20:47:37.475858 I  AOBase: Killing AudioOutputDSP
> 2021-11-15 20:47:37.482981 I  AOBase: OutputAudioLoop: Stop Event
> 2021-11-15 20:47:37.482999 I  AOBase: kickoffOutputAudioLoop exiting
> 2021-11-15 20:47:37.530944 I  TV::HandleStateChange(): Changing from 
> WatchingLiveTV to None
> 2021-11-15 20:47:37.531591 I  TV::StartTV(): Exiting main playback loop.
> 2021-11-15 20:47:37.532082 N  Resuming idle timer
> 2021-11-15 20:47:38.950682 I  Created ExitPrompter
> 2021-11-15 20:47:39.895791 I  Deleted ExitPrompter
> 2021-11-15 20:47:39.916458 I  UICache: Pruning cache directory: 
> /home/jim/.mythtv/cache/remotecache
> 2021-11-15 20:47:39.916568 I  UICache: Kept 18 files, deleted 0 files, 
> stat error on 0 files
> 2021-11-15 20:47:39.916576 I  UICache: Pruning cache directory: 
> /home/jim/.mythtv/cache/thumbnails
> 2021-11-15 20:47:39.917249 I  UICache: Kept 177 files, deleted 0 
> files, stat error on 0 files
> 2021-11-15 20:47:39.918478 I  Bonjour: De-registering service 
> '_mythfrontend._tcp.' on 'Mythfrontend on pop-os'
> 2021-11-15 20:47:39.919571 I  UDPListener: Disabling
> 2021-11-15 20:47:39.934056 I  InputHandler: Stopping
> 2021-11-15 20:47:39.934640 W  MythPainter: 60 images not yet de-allocated.
> 2021-11-15 20:47:39.934650 I  Clearing OpenGL painter cache.
> 2021-11-15 20:47:39.934887 I  OpenGL: MythRenderOpenGL closing
> 2021-11-15 20:47:39.937435 I  Display: Deleting
> 2021-11-15 20:47:39.939233 I  RAOP Device: Cleaning up.
> 2021-11-15 20:47:39.939238 I  AirPlay: Cleaning up.
> 2021-11-15 20:47:39.939418 I  Bonjour: De-registering service 
> '_airplay._tcp.' on 'MythTV on pop-os'
> 2021-11-15 20:47:39.939698 I  Shutting down UPnP client...
> 2021-11-15 20:47:42.603536 I  PowerDBus: Closing interfaces
> 2021-11-15 20:47:42.604485 I  Waiting for threads to exit.
> 2021-11-15 20:47:45.939929 I  Exiting
> jim at pop-os:~/build/mythtv/mythtv$
>
>
I see the message in your log that is the bug I fixed

2021-11-15 20:47:26.423153 E  [ac3_fixed @ 00007f644558dd60] Specified 
sample format s16p is invalid or not supported

Can you post the output of

mythfrontend --version

for the mythfrontend you ran to get that error

Peter


-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.mythtv.org/pipermail/mythtv-users/attachments/20211116/43fa03be/attachment.htm>