VLC 3.0.4 poor performance with H.265 mkv

[hazardass]

Win 7 x64, 4790K, GTX 980

Frequent micro-stutters during playback, CPU usage is about 25%.
During fastforwad / rewind, CPU jumps to 60-70%, and every jump takes a few second before playback resumes. That's horrible, and not what I am used to with H.264.

MPC-HC, on the other hand, plays H.265 MUCH smother. No stuttering, CPU is at 12% during normal playback, and about 45-50% when jumping through the video, but most importantly it takes almost no time to resume playback.

VLC has been my go-to player for many years, but now I have no choice but to switch to MPC because I've been converting my videos to H265. Any suggestions to improve playback in VLC would be appreciated.
Thanks.

[Hitchhiker]

Try using the Nightly build which 4.0.0

[unidan]

Hi, do you use d3d11 or d3d9 renderer ?

[Trizep]

I have the same Problem.
I have tried Ryzen 2400g, two diffrent NV GT1030 and now a NV GTX 1050 TI.

Ryzen:
With activated Hadware Acceleration I get a black/green screen(DXVA2+d3d11)CPU <5% GPU <50%. with deactivated HA stuttering CPU 50% GPU <5%.
NVIDA1030/1050:
Stuttering with or without HA (DXVA2+d3d11). 1030 = CPU <5% GPU 50% - with HDR GPU 75%

With MPC it works fine.

I have tested a 2160p movie with AVC. Thats works.
I have tested a 1080p movie with HEVC. Thats works.

Only "Real" 4k Movies (2160p+HEVC) didn´t work.

[hazardass]

Hi, do you use d3d11 or d3d9 renderer ?

I use default settings, whatever they are.

[unidan]

Can you post the full verbose log of video playback ?

To help you, we need messages, to completely understand what your problems is.
To fix this, please be sure before you start the playback to:

1. Open: Tools -> Messages.
2. Set Verbosity to 2
3. Start playback to reproduce your issue
4. Save text in a file or copy into clipboard
5. Then paste the full resulting log here between [​code]and[​/code] (or use Pastebin.com if it's too long)

Also don't forget to name your Operating System and provide the VLC media player version.

It might be your drivers or the renderer you use. You can change renderer from d3d11 to d3d9 in the settings, but please stil send us the logs and tell us if it works

[hazardass]

Can you post the full verbose log of video playback ?

My rendering was set to automatic by default. I tried changing to d3d9 and d3d11 but it didn't affect the performance.

In the log below I noticed that whenever there was a noticeable micro freeze in the video, it created a group of 3 warning lines in the log that look like this:

main warning: picture is too late to be displayed (missing 78 ms)
main warning: picture is too late to be displayed (missing 46 ms)
main warning: picture is too late to be displayed (missing 42 ms)

On average this happens probably once every 5-10 seconds in this type of video. When I play it with MPC-HC 1.7.17, playback is as smooth as a baby's butt. Not a hint of freezing.
The buffering sequence toward the end happened when I did a 10 second forward jump, which took about 2 seconds seek time. That's too long.

Code: Select all

main debug: processing request item: clip 2160p x265.mkv, node: Playlist, skip: 0 main debug: resyncing on clip 2160p x265.mkv main debug: clip 2160p x265.mkv is at 0 main debug: starting playback of new item main debug: resyncing on clip 2160p x265.mkv main debug: clip 2160p x265.mkv is at 0 main debug: creating new input thread main debug: Creating an input for 'clip 2160p x265.mkv' main debug: requesting art for new input thread main debug: using timeshift granularity of 50 MiB main debug: using timeshift path: C:\Users\Extreme4\AppData\Local\Temp main debug: `file:///D:/clip%202160p%20x265.mkv' gives access `file' demux `any' path `/D:/clip%202160p%20x265.mkv' main debug: creating demux: access='file' demux='any' location='/D:/clip%202160p%20x265.mkv' file='D:\clip 2160p x265.mkv' main debug: looking for access_demux module matching "file": 15 candidates main debug: no access_demux modules matched main debug: creating access: file:///D:/clip%202160p%20x265.mkv main debug: (path: D:\clip 2160p x265.mkv) main debug: looking for access module matching "file": 26 candidates main debug: using access module "filesystem" main debug: looking for stream_filter module matching "prefetch,cache_read": 24 candidates cache_read debug: Using stream method for AStream* cache_read debug: starting pre-buffering cache_read debug: received first data after 0 ms cache_read debug: pre-buffering done 1024 bytes in 0s - 1000000 KiB/s main debug: using stream_filter module "cache_read" main debug: looking for stream_filter module matching "any": 24 candidates main debug: looking for meta fetcher module matching "any": 1 candidates lua debug: Trying Lua scripts in C:\Users\Extreme4\AppData\Roaming\vlc\lua\playlist lua debug: Trying Lua scripts in C:\Users\Extreme4\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\playlist lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher main debug: no meta fetcher modules matched main debug: looking for art finder module matching "any": 2 candidates lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\anevia_streams.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\anevia_xml.luac lua debug: Trying Lua scripts in C:\Users\Extreme4\AppData\Roaming\vlc\lua\meta\art lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\art lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\appletrailers.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\bbc_co_uk.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\cue.luac qt debug: IM: Setting an input lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\dailymotion.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac main debug: no art finder modules matched lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\jamendo.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\koreus.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\liveleak.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\newgrounds.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\rockbox_fm_presets.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\soundcloud.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\twitch.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\vimeo.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\vocaroo.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\youtube.luac main debug: no stream_filter modules matched main debug: looking for stream_directory module matching "any": 1 candidates main debug: no stream_directory modules matched main debug: attachment of directory-extractor failed for file:///D:/clip%202160p%20x265.mkv main debug: looking for stream_filter module matching "record": 24 candidates main debug: using stream_filter module "record" main debug: creating demux: access='file' demux='any' location='/D:/clip%202160p%20x265.mkv' file='D:\clip 2160p x265.mkv' main debug: looking for demux module matching "mkv": 55 candidates mkv debug: | + Seek head mkv debug: | - info at 4151 mkv debug: | + Information mkv debug: | | + TimecodeScale=1000000 mkv debug: | | + Muxing Application=libebml v1.3.3 + libmatroska v1.4.4 mkv debug: | | + Writing Application=mkvmerge v8.5.2 ('Crosses') 64bit mkv debug: | | + Duration=3588001 mkv debug: | | + Date=Fri Apr 15 21:23:18 2016 mkv debug: | | + UID=1582928008 mkv debug: | - tracks at 4274 mkv debug: | + Tracks mkv debug: | | + Track Entry mkv debug: | | | + Track Number=1 mkv debug: | | | + Track UID=3346412694 mkv debug: | | | + Track Type=video mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track MinCache=1 mkv debug: | | | + Track CodecId=V_MPEGH/ISO/HEVC mkv debug: | | | + Track Video mkv debug: | | | | + width=3840 mkv debug: | | | | + height=2160 mkv debug: | | | | + display width=3840 mkv debug: | | | | + display height=2160 mkv debug: | | | + Track CodecPrivate size=1108 mkv debug: | | | + Track Default Duration=41708333 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=2 mkv debug: | | | + Track UID=1505958059 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track CodecId=A_AAC mkv debug: | | | + Track CodecPrivate size=7 mkv debug: | | | + Track Default Duration=42666666 mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=24000 mkv debug: | | | | + achan=6 mkv debug: | | | | + aoutfreq=48000 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=3 mkv debug: | | | + Track UID=593533576 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Default=0 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | - cues at 1900206808 mkv debug: | + Cues mkv debug: | - loading cues done. mkv debug: | - tags at 1900245067 mkv debug: | + Tags mkv debug: + Tag mkv debug: | + Targets mkv debug: | | + TargetTypeValue: 50 mkv debug: | | + LoadTag Unknown (N11libmatroska21KaxTagTargetTypeValueE) mkv debug: | | + TrackUID: 7081807011753899158 mkv debug: | | + LoadTag Unknown (N11libmatroska14KaxTagTrackUIDE) mkv debug: | | + TargetType: MOVIE mkv debug: | + Simple Tag mkv debug: | | + Meta BPS: 4049706 mkv debug: | + Simple Tag mkv debug: | | + Meta DURATION: 00:59:48.001000000 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_FRAMES: 86026 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_BYTES: 1816293889 mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_APP: mkvmerge v8.5.2 ('Crosses') 64bit mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_DATE_UTC: 2016-04-15 21:23:18 mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES mkv debug: + Tag mkv debug: | + Targets mkv debug: | | + TargetTypeValue: 50 mkv debug: | | + LoadTag Unknown (N11libmatroska21KaxTagTargetTypeValueE) mkv debug: | | + TrackUID: 9950374980686649515 mkv debug: | | + LoadTag Unknown (N11libmatroska14KaxTagTrackUIDE) mkv debug: | | + TargetType: MOVIE mkv debug: | + Simple Tag mkv debug: | | + Meta BPS: 185159 mkv debug: | + Simple Tag mkv debug: | | + Meta DURATION: 00:59:47.840000000 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_FRAMES: 84090 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_BYTES: 83040324 mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_APP: mkvmerge v8.5.2 ('Crosses') 64bit mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_DATE_UTC: 2016-04-15 21:23:18 mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES mkv debug: + Tag mkv debug: | + Targets mkv debug: | | + TargetTypeValue: 50 mkv debug: | | + LoadTag Unknown (N11libmatroska21KaxTagTargetTypeValueE) mkv debug: | | + TrackUID: 5402601867167439496 mkv debug: | | + LoadTag Unknown (N11libmatroska14KaxTagTrackUIDE) mkv debug: | | + TargetType: MOVIE mkv debug: | + Simple Tag mkv debug: | | + Meta BPS: 44 mkv debug: | + Simple Tag mkv debug: | | + Meta DURATION: 00:57:47.567000000 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_FRAMES: 732 mkv debug: | + Simple Tag mkv debug: | | + Meta NUMBER_OF_BYTES: 19316 mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_APP: mkvmerge v8.5.2 ('Crosses') 64bit mkv debug: | + Simple Tag mkv debug: | | + Meta _STATISTICS_WRITING_DATE_UTC: 2016-04-15 21:23:18 mkv debug: | + Simple Tag mkv debug: MKV/Ebml Parser: m_el[mi_level] == NULL mkv debug: | | + Meta _STATISTICS_TAGS: BPS DURATION NUMBER_OF_FRAMES NUMBER_OF_BYTES mkv debug: MKV/Ebml Parser: m_el[mi_level] == NULL mkv debug: loading tags done. mkv debug: | + Information mkv debug: | + Tracks mkv debug: | + Cluster mkv debug: NEW START CHAPTER uid=0 mkv debug: found 3 es main debug: selecting program id=0 mkv debug: seek: preroll{ track: 1, pts: 0, fpos: 5594 skip: 5594} mkv debug: seek: preroll{ req: 1, start-pts: 1, start-fpos: 5594} mkv debug: Starting the UI Hook main debug: using demux module "mkv" main debug: looking for a subtitle file in D:\ main debug: looking for video decoder module matching "any": 17 candidates avcodec debug: using ffmpeg Lavc58.6.103 avcodec debug: CPU flags: 0x000fd3db avcodec debug: allowing 9 thread(s) for decoding avcodec debug: codec (hevc) started avcodec debug: using frame thread mode with 9 threads main debug: using video decoder module "avcodec" main debug: looking for audio decoder module matching "any": 23 candidates main debug: using audio decoder module "faad" main debug: looking for meta reader module matching "any": 2 candidates lua debug: Trying Lua scripts in C:\Users\Extreme4\AppData\Roaming\vlc\lua\meta\reader lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\reader lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\reader\filename.luac main debug: no meta reader modules matched main debug: `file:///D:/clip%202160p%20x265.mkv' successfully opened main debug: Buffering 0% main debug: Buffering 13% main debug: Buffering 41% avcodec debug: available hardware decoder output format 53 (dxva2_vld) avcodec debug: available hardware decoder output format 118 (d3d11va_vld) avcodec debug: available hardware decoder output format 174 (d3d11) avcodec debug: available hardware decoder output format 119 (cuda) avcodec debug: available software decoder output format 64 (yuv420p10le) avcodec debug: trying format d3d11va_vld main debug: Buffering 55% main debug: Stream buffering done (334 ms in 1 ms) faad warning: decoded zero sample main debug: looking for text renderer module matching "any": 3 candidates faad debug: AAC SBR (channels: 6, samplerate: 48000) main debug: reusing audio output main debug: looking for aout stream module matching "any": 2 candidates freetype warning: DirectWrite initialization failed. Falling back to GDI/Uniscribe main debug: using text renderer module "freetype" main debug: looking for video converter module matching "any": 24 candidates swscale debug: 32x32 (32x32) chroma: YUVA -> 16x16 (16x16) chroma: RGBA with scaling using Bicubic (good quality) main debug: using video converter module "swscale" main debug: looking for video converter module matching "any": 24 candidates yuvp debug: YUVP to YUVA converter main debug: using video converter module "yuvp" main debug: Deinterlacing available main debug: deinterlace -1, mode auto, is_needed 0 main debug: looking for vout window module matching "qt,any": 3 candidates qt debug: requesting video window... wasapi debug: buffer size : 96000 frames wasapi debug: maximum latency: 10666600 ns wasapi debug: default period : 10000000 ns wasapi debug: minimum period : 3000000 ns main debug: using aout stream module "wasapi" main debug: output 'f32l' 48000 Hz 3F2R/LFE frame=1 samples/24 bytes main debug: looking for audio volume module matching "any": 2 candidates main debug: using audio volume module "float_mixer" main debug: input 'f32l' 48000 Hz 3F2R/LFE frame=1 samples/24 bytes main debug: looking for audio filter module matching "scaletempo": 16 candidates scaletempo debug: format: 48000 rate, 6 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz 3F2R/LFE->3F2R/LFE main debug: conversion pipeline complete main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz 3F2R/LFE->3F2R/LFE main debug: conversion pipeline complete main debug: looking for audio resampler module matching "any": 3 candidates main debug: using audio resampler module "samplerate" main debug: resized to 1920x962 main debug: resized to 1920x936 main debug: resized to 3840x2160 main debug: using vout window module "qt" main debug: looking for inhibit module matching "any": 1 candidates main debug: using inhibit module "inhibit" main debug: Opening vout display wrapper main debug: looking for vout display module matching "direct3d11": 12 candidates direct3d11 debug: creating Vout EventThread direct3d11 debug: Win32VoutCreateWindow main debug: VoutDisplayEvent 'resize' 3840x2160 direct3d11 debug: inclinometer not found. (hr=0x80070490) direct3d11 debug: created video sub-window direct3d11 debug: Vout EventThread running main debug: resized to 2024x1089 main debug: VoutDisplayEvent 'resize' 2024x1089 main debug: resized to 1920x936 main debug: VoutDisplayEvent 'resize' 1920x936 direct3d11 debug: Created the D3D11 device type 1 level 9300. direct3d11 warning: 10 bits swapchain failed, try 8 bits direct3d11 warning: could not get a IDXGISwapChain3 direct3d11 debug: Using pixel format I420_10 for chroma DX10 main debug: VoutDisplayEvent 'resize' 3856x2198 direct3d11 debug: Direct3D11 resources created direct3d11 debug: Direct3D11 device adapter successfully initialized direct3d11 debug: Direct3D11 Open Succeeded main debug: using vout display module "direct3d11" main debug: A filter to adapt decoder DX10 to display I0AL is needed main debug: looking for video converter module matching "any": 24 candidates main debug: using video converter module "d3d11_filters" main debug: Filter 'd3d11_filters' (0000000006c6aad0) appended to chain direct3d11 debug: D3D11 pool succeed with 5 surfaces (3840x2160) context 0x000000000d212c70 main debug: original format sz 3840x2160, of (0,0), vsz 3840x2160, 4cc DX10, sar 1:1, msk r0x0 g0x0 b0x0 main debug: removing module "freetype" main debug: looking for text renderer module matching "any": 3 candidates main debug: VoutDisplayEvent 'resize' 1920x936 freetype warning: DirectWrite initialization failed. Falling back to GDI/Uniscribe main debug: using text renderer module "freetype" main debug: looking for hw decoder module matching "any": 2 candidates main debug: no hw decoder modules matched avcodec debug: trying format dxva2_vld direct3d11 debug: Detected size change 1664x936 main debug: resized to 1920x936 main debug: removing module "d3d11_filters" main debug: VoutDisplayEvent 'resize' 1920x936 main debug: Filter 0000000006c6aad0 removed from chain main debug: removing module "direct3d11" direct3d11 debug: Direct3D11 resources destroyed direct3d11 debug: Direct3D11 device adapter closed direct3d11 error: SetThumbNailClip failed: 0x800706f4 direct3d11 debug: Win32 Vout EventThread terminating direct3d11 debug: Win32VoutCloseWindow direct3d11 debug: WinProc WM_DESTROY main debug: deinterlace -1, mode auto, is_needed 0 main debug: Opening vout display wrapper main debug: looking for vout display module matching "direct3d11": 12 candidates direct3d11 debug: creating Vout EventThread direct3d11 debug: Win32VoutCreateWindow main debug: VoutDisplayEvent 'resize' 1920x936 direct3d11 debug: inclinometer not found. (hr=0x80070490) main debug: resized to 1920x936 main debug: VoutDisplayEvent 'resize' 1920x936 direct3d11 debug: created video sub-window direct3d11 debug: Vout EventThread running direct3d11 debug: Created the D3D11 device type 1 level b000. direct3d11 debug: NVIDIA WDDM driver 25.21.14.1634 direct3d11 warning: could not get a IDXGISwapChain3 direct3d11 debug: Using pixel format I420 for chroma DXA0 main debug: VoutDisplayEvent 'resize' 3856x2198 direct3d11 debug: Direct3D11 resources created direct3d11 debug: Direct3D11 device adapter successfully initialized direct3d11 debug: Direct3D11 Open Succeeded main debug: using vout display module "direct3d11" main debug: A filter to adapt decoder DXA0 to display I420 is needed main debug: looking for video converter module matching "any": 24 candidates chain debug: Trying to use chroma I422 as middle man main debug: looking for video converter module matching "any": 24 candidates chain debug: Trying to use chroma I420 as middle man main debug: looking for video converter module matching "any": 24 candidates chain error: Too high level of recursion (3) main debug: no video converter modules matched main error: Failed to create video converter chain debug: Trying to use chroma I0AL as middle man main debug: looking for video converter module matching "any": 24 candidates d3d9_filters debug: Using Direct3D9 Extended API! main debug: using video converter module "d3d9_filters" main debug: Filter 'd3d9_filters' (0000000006c6b1b0) appended to chain main debug: looking for video converter module matching "any": 24 candidates swscale debug: 3840x2160 (3840x2160) chroma: I0AL -> 3840x2160 (3840x2160) chroma: I422 with scaling using Bicubic (good quality) main debug: using video converter module "swscale" main debug: Filter 'Swscale' (0000000006c6b520) appended to chain main debug: using video converter module "chain" main debug: Filter 'chain' (0000000006c6ae40) appended to chain main debug: looking for video converter module matching "any": 24 candidates swscale debug: 3840x2160 (3840x2160) chroma: I422 -> 3840x2160 (3840x2160) chroma: I420 with scaling using Bicubic (good quality) main debug: using video converter module "swscale" main debug: Filter 'Swscale' (0000000006c6b890) appended to chain main debug: using video converter module "chain" main debug: Filter 'chain' (0000000006c6aad0) appended to chain direct3d11 debug: D3D11 pool succeed with 5 surfaces (3840x2160) context 0x000000000d2cf560 main debug: original format sz 3840x2160, of (0,0), vsz 3840x2160, 4cc DXA0, sar 1:1, msk r0x0 g0x0 b0x0 main debug: reusing provided vout main debug: looking for hw decoder module matching "any": 2 candidates dxva2 debug: Using Direct3D9 Extended API! dxva2 debug: D3D9 device caps 0x1BBEF0 / 0x51 dxva2 debug: Direct3d9 Device: NVIDIA GeForce GTX 980 4318 5056 161 dxva2 debug: CreateDevice succeed dxva2 debug: OurDirect3DCreateDeviceManager9 Success! dxva2 debug: obtained IDirect3DDeviceManager9 dxva2 debug: - 'MPEG-2 & MPEG-1 variable-length decoder' is supported dxva2 debug: - 'MPEG-2 variable-length decoder' is supported dxva2 debug: - 'MPEG-1 variable-length decoder, no D pictures' is supported dxva2 debug: - 'VC-1 variable-length decoder' is supported dxva2 debug: - 'VC-1 variable-length decoder' is supported dxva2 debug: - 'Unknown decoder 0x32fcfe3f-0xde46-0x4a49-0x861bac71110649d5' is supported dxva2 debug: - 'H.264 stereo high profile, mbs flag set' is supported dxva2 debug: - 'H.264 stereo high profile' is supported dxva2 debug: - 'H.264 variable-length decoder, no film grain technology' is supported dxva2 debug: - 'HEVC Main profile' is supported dxva2 debug: - 'MPEG-4 Part 2 variable-length decoder, Simple Profile' is supported dxva2 debug: - 'MPEG-4 Part 2 variable-length decoder, Simple&Advanced Profile, no GMC' is supported dxva2 debug: - 'MPEG-4 Part 2 nVidia bitstream decoder' is supported dxva2 debug: - 'Unknown decoder 0x33fcfe41-0xde46-0x4a49-0x861bac71110649d5' is supported dxva2 debug: - 'Unknown decoder 0x6affd11e-0x1d96-0x42b1-0xa21593a31f09a53d' is supported dxva2 debug: - 'Unknown decoder 0x914c84a3-0x4078-0x4fa9-0x984ce2f262cb5c9c' is supported dxva2 warning: Unsupported profile 2 for HEVC Main profile dxva2 error: FindVideoServiceConversion failed main debug: VoutDisplayEvent 'resize' 1920x936 main debug: no hw decoder modules matched direct3d11 debug: Detected size change 1664x936 main debug: removing module "chain" main debug: resized to 1920x936 main debug: removing module "chain" main debug: VoutDisplayEvent 'resize' 1920x936 main debug: removing module "d3d9_filters" main debug: Filter 0000000006c6b1b0 removed from chain main debug: removing module "swscale" main debug: Filter 0000000006c6b520 removed from chain main debug: Filter 0000000006c6ae40 removed from chain main debug: removing module "swscale" main debug: Filter 0000000006c6b890 removed from chain main debug: Filter 0000000006c6aad0 removed from chain main debug: removing module "direct3d11" direct3d11 debug: Direct3D11 resources destroyed direct3d11 debug: Direct3D11 device adapter closed direct3d11 error: SetThumbNailClip failed: 0x800706f4 direct3d11 debug: Win32 Vout EventThread terminating direct3d11 debug: Win32VoutCloseWindow direct3d11 debug: WinProc WM_DESTROY main debug: deinterlace -1, mode auto, is_needed 0 main debug: Opening vout display wrapper main debug: looking for vout display module matching "direct3d11": 12 candidates direct3d11 debug: creating Vout EventThread direct3d11 debug: Win32VoutCreateWindow main debug: VoutDisplayEvent 'resize' 1920x936 main debug: resized to 1920x936 main debug: VoutDisplayEvent 'resize' 1920x936 direct3d11 debug: inclinometer not found. (hr=0x80070490) direct3d11 debug: created video sub-window direct3d11 debug: Vout EventThread running direct3d11 debug: Created the D3D11 device type 1 level b000. direct3d11 debug: NVIDIA WDDM driver 25.21.14.1634 direct3d11 warning: could not get a IDXGISwapChain3 direct3d11 debug: Using pixel format I420_10 for chroma I0AL main debug: VoutDisplayEvent 'resize' 3856x2198 direct3d11 debug: Direct3D11 resources created direct3d11 debug: Direct3D11 device adapter successfully initialized direct3d11 debug: Direct3D11 Open Succeeded main debug: using vout display module "direct3d11" direct3d11 debug: D3D11 pool succeed with 46 surfaces (3840x2176) context 0x000000000d2cf560 main debug: original format sz 3840x2176, of (0,0), vsz 3840x2160, 4cc I0AL, sar 1:1, msk r0x0 g0x0 b0x0 qt debug: Qt: Fullscreen state changed main debug: reusing provided vout avcodec warning: plane 0 not aligned: disabling direct rendering main debug: VoutDisplayEvent 'resize' 1920x936 direct3d11 debug: Detected size change 1664x936 main debug: resized to 1920x936 main debug: VoutDisplayEvent 'resize' 1920x936 main error: buffer deadlock prevented main debug: Decoder wait done in 446 ms main debug: inserting 3968 zeroes mmdevice debug: state changed: 1 main warning: picture is too late to be displayed (missing 70 ms) main warning: picture is too late to be displayed (missing 37 ms) main debug: picture might be displayed late (missing 3 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 78 ms) main warning: picture is too late to be displayed (missing 46 ms) main warning: picture is too late to be displayed (missing 42 ms) main debug: auto hiding mouse cursor qt debug: Using a general info windows main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 73 ms) main warning: picture is too late to be displayed (missing 39 ms) main debug: picture might be displayed late (missing 6 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 100 ms) main warning: picture is too late to be displayed (missing 71 ms) main warning: picture is too late to be displayed (missing 39 ms) main debug: picture might be displayed late (missing 8 ms) main debug: auto hiding mouse cursor main debug: resized to 944x939 main debug: VoutDisplayEvent 'resize' 944x939 main debug: VoutDisplayEvent 'resize' 944x939 direct3d11 debug: Detected size change 944x531 main debug: auto hiding mouse cursor main debug: auto hiding mouse cursor mkv debug: seek request to 6.49% wasapi debug: reset mmdevice debug: state changed: 0 mkv debug: seek: preroll{ track: 1, pts: 230355000, fpos: 129458358 skip: 129458358} mkv debug: seek: preroll{ track: 2, pts: 232777000, fpos: 130711660 skip: 130711660} mkv debug: seek: preroll{ req: 232861278, start-pts: 230355001, start-fpos: 129458358} main debug: Buffering 0% main debug: Buffering 1% main debug: Buffering 4% main debug: Buffering 5% main debug: Buffering 11% main debug: Buffering 13% main debug: Buffering 19% main debug: Buffering 20% main debug: Buffering 26% main debug: Buffering 28% main debug: Buffering 34% main debug: Buffering 35% main debug: Buffering 41% main debug: Buffering 43% main debug: Buffering 49% main debug: Buffering 50% main debug: Buffering 56% main debug: Buffering 57% main debug: Buffering 63% main debug: Buffering 65% main debug: Buffering 71% main debug: Buffering 72% main debug: Buffering 78% main debug: Buffering 80% main debug: Buffering 86% main debug: Buffering 87% main debug: Buffering 93% main debug: end of audio preroll wasapi debug: reset main debug: Buffering 95% main debug: Stream buffering done (2836 ms in 29 ms) main error: buffer deadlock prevented main debug: Decoder wait done in 791 ms mmdevice debug: state changed: 1 main debug: end of video preroll main warning: picture is too late to be displayed (missing 87 ms) main warning: picture is too late to be displayed (missing 59 ms) main warning: picture is too late to be displayed (missing 32 ms) main debug: picture might be displayed late (missing 2 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 80 ms) main warning: picture is too late to be displayed (missing 47 ms) main debug: picture might be displayed late (missing 14 ms) main warning: picture is too late to be displayed (missing 103 ms) main warning: picture is too late to be displayed (missing 73 ms) main warning: picture is too late to be displayed (missing 40 ms) main debug: picture might be displayed late (missing 8 ms) main warning: picture is too late to be displayed (missing 83 ms) main warning: picture is too late to be displayed (missing 49 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 68 ms) main warning: picture is too late to be displayed (missing 33 ms) main debug: picture might be displayed late (missing 1 ms) main debug: auto hiding mouse cursor mkv debug: SET_TIME to 294384278 mkv debug: seek request to i_pos = 294384278 mmdevice debug: state changed: 0 wasapi debug: reset mkv debug: seek: preroll{ track: 1, pts: 287996000, fpos: 153911177 skip: 153911177} mkv debug: seek: preroll{ track: 2, pts: 294089000, fpos: 156820132 skip: 156820132} mkv debug: seek: preroll{ req: 294384279, start-pts: 287996001, start-fpos: 153911177} main debug: Buffering 0% main debug: Buffering 1% main debug: Buffering 2% main debug: Buffering 4% main debug: Buffering 5% main debug: Buffering 8% main debug: Buffering 11% main debug: Buffering 14% main debug: Buffering 17% main debug: Buffering 18% main debug: Buffering 20% main debug: Buffering 21% main debug: Buffering 23% main debug: Buffering 24% main debug: Buffering 26% main debug: Buffering 27% main debug: Buffering 29% main debug: Buffering 30% main debug: Buffering 33% main debug: Buffering 36% main debug: Buffering 39% main debug: Buffering 42% main debug: Buffering 43% main debug: Buffering 45% main debug: Buffering 46% main debug: Buffering 48% main debug: Buffering 49% main debug: Buffering 51% main debug: Buffering 52% main debug: Buffering 54% main debug: Buffering 55% main debug: Buffering 57% main debug: Buffering 58% main debug: Buffering 61% main debug: Buffering 64% main debug: Buffering 67% main debug: Buffering 70% main debug: Buffering 71% main debug: Buffering 73% main debug: Buffering 74% main debug: Buffering 76% main debug: Buffering 77% main debug: Buffering 79% main debug: Buffering 80% main debug: Buffering 82% main debug: Buffering 83% main debug: Buffering 86% main debug: Buffering 89% main debug: Buffering 92% main debug: Buffering 95% main debug: Buffering 96% main debug: Buffering 98% main debug: Buffering 99% main debug: Stream buffering done (6798 ms in 13 ms) main debug: end of audio preroll wasapi debug: reset main error: buffer deadlock prevented main debug: Decoder wait done in 1891 ms mmdevice debug: state changed: 1 main debug: end of video preroll main warning: picture is too late to be displayed (missing 81 ms) main warning: picture is too late to be displayed (missing 47 ms) main debug: picture might be displayed late (missing 13 ms) main debug: auto hiding mouse cursor main debug: toggling resume main debug: toggling resume mmdevice debug: state changed: 0 main debug: auto hiding mouse cursor

[marcow]

This might be related to any of the following issues:

forum.videolan.org/viewtopic.php?p=479105#p479105
forum.videolan.org/viewtopic.php?p=480567#p480567
forum.videolan.org/viewtopic.php?p=480906#p480906
https://forum.videolan.org/viewtopic.ph ... 55#p481455
https://forum.videolan.org/viewtopic.ph ... 62#p481462
https://forum.videolan.org/viewtopic.ph ... 86#p481986
https://forum.videolan.org/viewtopic.ph ... 35#p482335
https://forum.videolan.org/viewtopic.ph ... 44#p482944
https://forum.videolan.org/viewtopic.ph ... 67#p483267
https://forum.videolan.org/viewtopic.ph ... 38#p483738
https://forum.videolan.org/viewtopic.ph ... 08#p483908

[hazardass]

damn, so many topics on this. It seems the VLC team have their work cut out for them. It can't be easy to stay ahead all the time.

I'm done with VLC for now. MPC handles x265 much better.