[mythtv-users] Status of ffmpeg 4.4.1

James Abernathy jfabernathy at gmail.com
Tue Nov 16 14:59:05 UTC 2021 

On Tue, Nov 16, 2021 at 9:47 AM James Abernathy <jfabernathy at gmail.com>
wrote:

>
>
> On Tue, Nov 16, 2021 at 9:40 AM James Abernathy <jfabernathy at gmail.com>
> wrote:
>
>>
>>
>> On Tue, Nov 16, 2021 at 9:26 AM Peter Bennett <pb.mythtv at gmail.com>
>> wrote:
>>
>>>
>>> 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>
>>> 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
>>>
>> Answer below, but I'll tell you specifically how I did the test.
>> 1. git checkout master
>> 2. git clean -xfd
>> 3. cd mythtv
>> 4. ./configure --prefix=/usr
>> 5. make -j 8
>> 6. sudo make install
>>
>> Then I made sure that mythtfrontend audio set upconvert stereo to 5.1 was
>> checked and then tuned to a stereo TV station.
>>
>> jim at pop-os:~/build/mythtv/mythtv$ mythfrontend --version
>> Please attach all output as a file in bug reports.
>> MythTV Version : v32-Pre-2984-g57a388e222
>> MythTV Branch : master
>> Network Protocol : 91
>> Library API : 32.20200101-1
>> QT Version : 5.12.8
>> Options compiled in:
>>  linux profile use_hidesyms using_alsa using_oss using_pulse
>> using_pulseoutput using_backend using_bindings_perl using_bindings_python
>> using_bindings_php using_dvb using_firewire using_frontend using_hdhomerun
>> using_satip using_vbox using_ceton using_joystick_menu using_libcrypto
>> using_gnutls using_libdns_sd using_libfftw3 using_libxml2 using_lirc
>> using_mheg using_opengl using_egl using_qtwebkit using_qtscript
>> using_qtdbus using_taglib using_v4l2 using_v4l2prime using_x11
>> using_libbluray_external using_systemd_notify using_systemd_journal
>> using_drm using_bindings_perl using_bindings_python using_bindings_php
>> using_freetype2 using_mythtranscode using_opengl using_egl using_drm
>> using_vaapi using_nvdec using_vdpau using_ffmpeg_threads using_mheg
>> using_libass using_libxml2
>>
>> Jim A
>>
>
> if I do the reverse and git checkout devel/ffmpeg-resync I get this
> version:
> jim at pop-os:~/build/mythtv/mythtv$ mythfrontend --version
> Please attach all output as a file in bug reports.
> MythTV Version : v32-Pre-2988-g076bc592b6
> MythTV Branch : devel/ffmpeg-resync
> Network Protocol : 91
> Library API : 32.20200101-1
> QT Version : 5.12.8
> Options compiled in:
>  linux profile use_hidesyms using_alsa using_oss using_pulse
> using_pulseoutput using_backend using_bindings_perl using_bindings_python
> using_bindings_php using_dvb using_firewire using_frontend using_hdhomerun
> using_satip using_vbox using_ceton using_joystick_menu using_libcrypto
> using_gnutls using_libdns_sd using_libfftw3 using_libxml2 using_lirc
> using_mheg using_opengl using_egl using_qtwebkit using_qtscript
> using_qtdbus using_taglib using_v4l2 using_v4l2prime using_x11
> using_libbluray_external using_systemd_notify using_systemd_journal
> using_drm using_bindings_perl using_bindings_python using_bindings_php
> using_freetype2 using_mythtranscode using_opengl using_egl using_drm
> using_vaapi using_nvdec using_vdpau using_ffmpeg_threads using_mheg
> using_libass using_libxml2
> jim at pop-os:~/build/mythtv/mythtv$
>
>  Now I get audio on the stereo station with upconvert to 5.1 set.
>
> Maybe my git clean -xfd didn't remove enough of the residual stuff for the
> complete master to get rebuilt??
>
> JIm A
>

to test out a bad rebuild, I deleted my complete mythtv directory and did
the git clone again.  Same results. Master fails on upconverting stereo but
devel/ffmgep-resync works fine.

Jim A
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.mythtv.org/pipermail/mythtv-users/attachments/20211116/428442be/attachment.htm>

More information about the mythtv-users mailing list