VLC Plays ProRes/DNX etc at Very Low Frame Rate Stuttery- Default Settings

[ghosty999]

Hello.

Having extremely low frame-rate playback in VLC when playing: AVC, DNxHD, ProRes etc. Play back is correct with H.264 though.

Hardware is an HP Z8 G4 Workstation with 2 x Xeon Gold 5118, 100gig RAM and a Quadro P4000 GPU.

VLC is the latest version and default settings (no hardware enabled and default settings).

This issue occurs on around 6 other machines so it's not isolated to this PC.

The files play back normal smooth frame rate in Premier, AVID Media Composer, Resolve etc.

[Lotesdelere]

Please open Tools -> Messages (set Verbosity to 2) before you start the playback, and then paste the full resulting log here or on Pastebin.com or on Justpaste.it if it's too long.

Also upload a short sample of your original problematic file to WeTransfer.com or Disroot.org and then post the link to the file here.
https://wetransfer.com
https://upload.disroot.org

If needed cut it with DGsplit and read here about how to do it:
https://forum.videolan.org/viewtopic.ph ... 35#p193335
200 MB max should be enough but a full complete short file is better.

[ghosty999]

Please open Tools -> Messages (set Verbosity to 2) before you start the playback, and then paste the full resulting log here or on Pastebin.com or on Justpaste.it if it's too long.

Thankyou for your reply. I'm requesting permission to send on a clip. Debug output below when playing back a generic ProRes 422 HQ file at 25p 1920x1080:

main debug: VoutDisplayEvent 'mouse button' 0 t=8
main debug: VoutDisplayEvent 'mouse button' 0 t=9
main debug: toggling pause
main debug: toggling pause
mmdevice debug: state changed: 1
main warning: picture is too late to be displayed (missing 39 ms)
main warning: picture is too late to be displayed (missing 37 ms)
main warning: picture is too late to be displayed (missing 36 ms)
main warning: picture is too late to be displayed (missing 35 ms)
main warning: picture is too late to be displayed (missing 33 ms)
main warning: picture is too late to be displayed (missing 32 ms)
main warning: picture is too late to be displayed (missing 31 ms)
main warning: picture is too late to be displayed (missing 28 ms)
main warning: picture is too late to be displayed (missing 27 ms)
main warning: picture is too late to be displayed (missing 25 ms)
main warning: picture is too late to be displayed (missing 23 ms)
main warning: picture is too late to be displayed (missing 21 ms)
main debug: picture might be displayed late (missing 20 ms)
main warning: picture is too late to be displayed (missing 58 ms)
main debug: picture might be displayed late (missing 18 ms)
main warning: picture is too late to be displayed (missing 56 ms)
main debug: picture might be displayed late (missing 16 ms)
main warning: picture is too late to be displayed (missing 55 ms)
main debug: picture might be displayed late (missing 15 ms)
main warning: picture is too late to be displayed (missing 54 ms)
main debug: picture might be displayed late (missing 14 ms)
main debug: auto hiding mouse cursor
main warning: picture is too late to be displayed (missing 51 ms)
main debug: picture might be displayed late (missing 11 ms)
main warning: picture is too late to be displayed (missing 50 ms)
main debug: picture might be displayed late (missing 10 ms)
main warning: picture is too late to be displayed (missing 47 ms)
main debug: picture might be displayed late (missing 7 ms)
main warning: picture is too late to be displayed (missing 46 ms)
main debug: picture might be displayed late (missing 6 ms)
main warning: picture is too late to be displayed (missing 45 ms)
main debug: picture might be displayed late (missing 5 ms)
main warning: picture is too late to be displayed (missing 42 ms)
main debug: picture might be displayed late (missing 2 ms)
main warning: picture is too late to be displayed (missing 40 ms)
main warning: picture is too late to be displayed (missing 39 ms)
main warning: picture is too late to be displayed (missing 36 ms)
main warning: picture is too late to be displayed (missing 34 ms)
main warning: picture is too late to be displayed (missing 32 ms)
main warning: picture is too late to be displayed (missing 30 ms)
main warning: picture is too late to be displayed (missing 29 ms)
main warning: picture is too late to be displayed (missing 28 ms)
main warning: picture is too late to be displayed (missing 26 ms)
main warning: picture is too late to be displayed (missing 24 ms)
main warning: picture is too late to be displayed (missing 23 ms)
main warning: picture is too late to be displayed (missing 22 ms)

[Lotesdelere]

Read my post again, I asked for a full complete log, from the very beginning to the very end.
AND a short sample file.

[Rémi Denis-Courmont]

It seems that your computer just can't keep up with decoding in real-time here. Can you try with reduced playback speed?

[ghosty999]

Read my post again, I asked for a full complete log, from the very beginning to the very end.
AND a short sample file.

Come on now, be nice to newbies

Sample Clip: https://we.tl/t-CW0WCeFwox (this is a prores, the low frame-rate issue happens for most MXF Op1a wrapped files with ProRes, DNxHD, AVC Intra etc)

Full report: https://we.tl/t-gIU0nrNfFh

[Lotesdelere]

Once again, we need the full complete log, from the very beginning to the very end.
Open Tools -> Messages (set Verbosity to 2) before you start the playback and keep it open.

[ghosty999]

Once again, we need the full complete log, from the very beginning to the very end.
Open Tools -> Messages (set Verbosity to 2) before you start the playback and keep it open.

You'll have to tell me where I'm going wrong? I open VLC, set messages to 2, press play, wait, press stop, save the .log output file, upload. Try a less aggressive approach.

[ghosty999]

It seems that your computer just can't keep up with decoding in real-time here. Can you try with reduced playback speed?

Ahh interesting. It's a fairly high end video workstation so that is strange! Half playback speed has the same issue

[Lotesdelere]

You'll have to tell me where I'm going wrong? I open VLC, set messages to 2, press play, wait, press stop, save the .log output file, upload.

But what you upload is a very small part of the log. We want it all, from the very beginning because we need the file opening sequence.
It should start with something like that:

Code: Select all

main debug: processing request item: TEST_FILE.mxf, node: Playlist, skip: 0 main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index 0 main debug: starting playback of new item main debug: resyncing on TEST_FILE.mxf main debug: TEST_FILE-t=163890.mxf is at 0 main debug: creating new input thread main debug: Creating an input for 'TEST_FILE.mxf' ...

Open VLC, open the messages window then set verbosity to 2 and KEEP the messages window OPEN during the whole process.
Then drag and drop your video file into the VLC window and let it play till the end. Then save the whole messages log.

That said, your hardware should easily support that kind of files.
I'm getting similar warning messages to yours when automatic deinterlacing kicks in. I guess your full log will confirm that.

[ghosty999]

You'll have to tell me where I'm going wrong? I open VLC, set messages to 2, press play, wait, press stop, save the .log output file, upload.

But what you upload is a very small part of the log. We want it all, from the very beginning because we need the file opening sequence.
It should start with something like that:

Code: Select all

main debug: processing request item: TEST_FILE.mxf, node: Playlist, skip: 0 main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index 0 main debug: starting playback of new item main debug: resyncing on TEST_FILE.mxf main debug: TEST_FILE-t=163890.mxf is at 0 main debug: creating new input thread main debug: Creating an input for 'TEST_FILE.mxf' ...

Open VLC, open the messages window then set verbosity to 2 and KEEP the messages window OPEN during the whole process.
Then drag and drop your video file into the VLC window and let it play till the end. Then save the whole messages log.

That said, your hardware should easily support that kind of files.
I'm getting similar warning messages to yours when automatic deinterlacing kicks in. I guess your full log will confirm that.

That is very strange as that is what I did. Here is a second attempt and I've screen captured the process. I played the file for 2 mins or so.

Screen Capture of what I am doing: https://we.tl/t-bTxRyQlMFw (I've spliced this to show start and finish)

The Log from that video: https://we.tl/t-MG3CbBTtyj

[Lotesdelere]

Now we have a full log. And what I suspected is confirmed: the problem comes from deinterlacing:

Code: Select all

main debug: Detected interlaced video main debug: deinterlace -1, mode auto, is_needed 1 main debug: Adding 'deinterlace' as static main debug: looking for video filter module matching "deinterlace,chain": 46 candidates deinterlace error: unknown or incompatible deinterlace mode "x" for high depth format deinterlace debug: using blend deinterlace method deinterlace debug: deinterlacing main debug: using video filter module "deinterlace" main debug: Filter 'deinterlace' (000001fb866e94f0) appended to chain main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 66 ms)

You should create a new report ticket on the VLC issues tracker with your above report, the link to your sample file and the link to this thread:
https://code.videolan.org/videolan/vlc/-/issues

If possible, because of this:
https://forum.videolan.org/viewtopic.ph ... 27#p538427

[ghosty999]

Now we have a full log. And what I suspected is confirmed: the problem comes from deinterlacing:

You should create a new report ticket on the VLC issues tracker with your above report, the link to your sample file and the link to this thread:
https://code.videolan.org/videolan/vlc/-/issues

If possible, because of this:
https://forum.videolan.org/viewtopic.ph ... 27#p538427

Thankyou sir. I will do. It seems to happen on files in MBAFF and interleaved fields interlaced. Almost as if it's missreading the metadata as 25i rather than the 50i and playingback in half time? Just spit balling... I'll hand it over to the pros.