Postby Marcusdeman » 04 Dec 2018 14:06
Here is the logfile.
I tried cutting a short part of the movie with Avidemux but the saved version was displayed correctly.
Hopefully the logfile already shows the culprit?
logfile:
main debug: processing request item: Clip.mp4, 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: Creating an input for preparsing 'Clip.mp4'
main debug: resyncing on Clip.mp4
main debug: Clip.mp4 is at 0
main debug: creating new input thread
main debug: Creating an input for 'Clip.mp4'
main debug: looking for meta fetcher module matching "any": 1 candidates
main debug: requesting art for new input thread
main debug: using timeshift granularity of 50 MiB
main debug: using timeshift path: c:\Temp
main debug: `file:///Z:/Clip.mp4' gives access `file' demux `any' path `/Z:/Clip.mp4'
lua debug: Trying Lua scripts in C:\Users\Superduper\AppData\Roaming\vlc\lua\meta\fetcher
main debug: creating demux: access='file' demux='any' location='/Z:/Clip.mp4' file='Z:\Clip.mp4'
main debug: looking for access_demux module matching "file": 15 candidates
lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher
main debug: no meta fetcher modules matched
main debug: looking for art finder module matching "any": 2 candidates
main debug: no access_demux modules matched
main debug: creating access: file:///Z:/Clip.mp4
main debug: (path: Z:\Clip.mp4)
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
qt debug: IM: Setting an input
lua debug: Trying Lua scripts in C:\Users\Superduper\AppData\Roaming\vlc\lua\playlist
lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\playlist
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\anevia_streams.luac
lua debug: Trying Lua scripts in C:\Users\Superduper\AppData\Roaming\vlc\lua\meta\art
lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\anevia_xml.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\appletrailers.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\bbc_co_uk.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\cue.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
main debug: no art finder modules matched
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\dailymotion.luac
main debug: looking for meta fetcher module matching "any": 1 candidates
lua debug: Trying Lua scripts in C:\Users\Superduper\AppData\Roaming\vlc\lua\meta\fetcher
lua debug: Trying Lua scripts in C:\Program Files (x86)\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 (x86)\VideoLAN\VLC\lua\playlist\jamendo.luac
lua debug: Trying Lua scripts in C:\Users\Superduper\AppData\Roaming\vlc\lua\meta\art
lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\koreus.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\liveleak.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\newgrounds.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\rockbox_fm_presets.luac
lua debug: skipping script (unmatched scope) C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
main debug: no art finder modules matched
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\soundcloud.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\twitch.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\vimeo.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\playlist\vocaroo.luac
lua debug: Trying Lua playlist script C:\Program Files (x86)\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:///Z:/Clip.mp4
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='/Z:/Clip.mp4' file='Z:\Clip.mp4'
main debug: looking for demux module matching "mp4": 55 candidates
mp4 warning: unknown box type smrd (incompletely loaded)
mp4 warning: unknown box type smta (incompletely loaded)
mp4 debug: dumping root Box "root"
mp4 debug: | + ftyp size 24 offset 0
mp4 debug: | + mdat size 366199337 offset 24
mp4 debug: | + moov size 106723 offset 366199361
mp4 debug: | | + mvhd size 108 offset 366199369
mp4 debug: | | + udta size 96 offset 366199477
mp4 debug: | | | + SDLN size 16 offset 366199485
mp4 debug: | | | + smrd size 16 offset 366199501 (????)
mp4 debug: | | | + cxyz size 30 offset 366199517
mp4 debug: | | | + smta size 26 offset 366199547 (????)
mp4 debug: | | + meta size 180 offset 366199573
mp4 debug: | | | + hdlr size 33 offset 366199581
mp4 debug: | | | + keys size 74 offset 366199614
mp4 debug: | | | + ilst size 65 offset 366199688
mp4 debug: | | | | + data size 21 offset 366199704
mp4 debug: | | | | + data size 20 offset 366199733
mp4 debug: | | + trak size 66512 offset 366199753
mp4 debug: | | | + tkhd size 92 offset 366199761
mp4 debug: | | | + mdia size 66412 offset 366199853
mp4 debug: | | | | + mdhd size 32 offset 366199861
mp4 debug: | | | | + hdlr size 44 offset 366199893
mp4 debug: | | | | + minf size 66328 offset 366199937
mp4 debug: | | | | | + vmhd size 20 offset 366199945
mp4 debug: | | | | | + dinf size 36 offset 366199965
mp4 debug: | | | | | | + dref size 28 offset 366199973
mp4 debug: | | | | | | | + url size 12 offset 366199989
mp4 debug: | | | | | + stbl size 66264 offset 366200001
mp4 debug: | | | | | | + stsd size 176 offset 366200009
mp4 debug: | | | | | | | + avc1 size 160 offset 366200025
mp4 debug: | | | | | | | | + avcC size 39 offset 366200111
mp4 debug: | | | | | | | | + pasp size 16 offset 366200150
mp4 debug: | | | | | | | | + colr size 19 offset 366200166
mp4 debug: | | | | | | + stts size 39632 offset 366200185
mp4 debug: | | | | | | + stss size 840 offset 366239817
mp4 debug: | | | | | | + stsz size 24668 offset 366240657
mp4 debug: | | | | | | + stsc size 124 offset 366265325
mp4 debug: | | | | | | + stco size 816 offset 366265449
mp4 debug: | | + trak size 39819 offset 366266265
mp4 debug: | | | + tkhd size 92 offset 366266273
mp4 debug: | | | + mdia size 39719 offset 366266365
mp4 debug: | | | | + mdhd size 32 offset 366266373
mp4 debug: | | | | + hdlr size 44 offset 366266405
mp4 debug: | | | | + minf size 39635 offset 366266449
mp4 debug: | | | | | + smhd size 16 offset 366266457
mp4 debug: | | | | | + dinf size 36 offset 366266473
mp4 debug: | | | | | | + dref size 28 offset 366266481
mp4 debug: | | | | | | | + url size 12 offset 366266497
mp4 debug: | | | | | + stbl size 39575 offset 366266509
mp4 debug: | | | | | | + stsd size 91 offset 366266517
mp4 debug: | | | | | | | + mp4a size 75 offset 366266533
mp4 debug: | | | | | | | | + esds size 39 offset 366266569
mp4 debug: | | | | | | + stts size 32 offset 366266608
mp4 debug: | | | | | | + stsz size 38556 offset 366266640
mp4 debug: | | | | | | + stsc size 52 offset 366305196
mp4 debug: | | | | | | + stco size 836 offset 366305248
mp4 debug: unrecognized major media specification (mp42).
mp4 debug: found 2 tracks
mp4 debug: track[Id 0x1] read 200 chunk
mp4 warning: STTS table of 4952 entries
mp4 debug: track[Id 0x1] read 6162 samples length:205s
main debug: selecting program id=0
mp4 debug: adding track[Id 0x1] video (enable) language eng
mp4 debug: track[Id 0x2] read 205 chunk
mp4 warning: STTS table of 2 entries
mp4 debug: track[Id 0x2] read 9634 samples length:205s
mp4 debug: adding track[Id 0x2] audio (enable) language eng
main debug: using demux module "mp4"
main debug: looking for a subtitle file in Z:\
main debug: looking for video decoder module matching "any": 17 candidates
avcodec debug: using ffmpeg Lavc58.6.103
avcodec debug: CPU flags: 0x0000107f
avcodec debug: allowing 4 thread(s) for decoding
avcodec debug: codec (h264) started
avcodec debug: using frame thread mode with 4 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\Superduper\AppData\Roaming\vlc\lua\meta\reader
lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader
lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader\filename.luac
main debug: no meta reader modules matched
main debug: `file:///Z:/Clip.mp4' successfully opened
mp4 debug: track[Id 0x1] using Sync Sample Box (stss)
mp4 debug: stss gives 0 --> 0 (sample number)
main debug: Buffering 0%
faad warning: decoded zero sample
main debug: reusing audio output
main debug: looking for aout stream module matching "any": 2 candidates
main debug: Buffering 83%
main debug: Stream buffering done (500 ms in 10 ms)
avcodec debug: available hardware decoder output format 119 (cuda)
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 software decoder output format 0 (yuv420p)
avcodec debug: trying format d3d11va_vld
main debug: looking for text renderer module matching "any": 3 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 Stereo frame=1 samples/8 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 Stereo frame=1 samples/8 bytes
main debug: looking for audio filter module matching "scaletempo": 16 candidates
scaletempo debug: format: 48000 rate, 2 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 Stereo->Stereo
main debug: conversion pipeline complete
main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
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 1238x469
main debug: resized to 1920x1080
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 "any": 12 candidates
main debug: resized to 1920x989
direct3d9 debug: Using Direct3D9 Extended API!
direct3d9 debug: creating Vout EventThread
direct3d9 debug: Win32VoutCreateWindow
main debug: VoutDisplayEvent 'resize' 1920x989
direct3d9 debug: inclinometer not found. (hr=0x80070490)
direct3d9 debug: created video sub-window
direct3d9 debug: Vout EventThread running
direct3d9 debug: D3D9 device caps 0x1BBEF0 / 0x71
direct3d9 debug: Direct3d9 Device: ATI Radeon HD 4600 Series 4098 38032 0
main debug: resized to 1920x904
main debug: VoutDisplayEvent 'resize' 1920x904
direct3d9 warning: trying surface pixel format: NV12
direct3d9 debug: selected surface pixel format is NV12
main debug: VoutDisplayEvent 'resize' 1096x1958
direct3d9 debug: Direct3D9 scene created successfully
direct3d9 debug: Direct3D9 device adapter successfully initialized
main debug: using vout display module "direct3d9"
main debug: A filter to adapt decoder DX11 to display NV12 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' (06d70070) appended to chain
main debug: original format sz 1920x1088, of (0,0), vsz 1920x1080, 4cc DX11, sar 1:1, msk r0x0 g0x0 b0x0
main debug: removing module "freetype"
main debug: VoutDisplayEvent 'resize' 1920x904
main debug: looking for text renderer module matching "any": 3 candidates
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
main debug: removing module "d3d11_filters"
main debug: Filter 06d70070 removed from chain
main debug: removing module "direct3d9"
direct3d9 debug: Direct3D9 scene released successfully
main debug: resized to 1920x904
main debug: VoutDisplayEvent 'resize' 1920x904
direct3d9 error: SetThumbNailClip failed: 0x800706f4
direct3d9 debug: Win32 Vout EventThread terminating
direct3d9 debug: Win32VoutCloseWindow
direct3d9 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 "any": 12 candidates
direct3d9 debug: Using Direct3D9 Extended API!
direct3d9 debug: creating Vout EventThread
direct3d9 debug: Win32VoutCreateWindow
main debug: VoutDisplayEvent 'resize' 1920x904
direct3d9 debug: inclinometer not found. (hr=0x80070490)
direct3d9 debug: created video sub-window
direct3d9 debug: Vout EventThread running
direct3d9 debug: D3D9 device caps 0x1BBEF0 / 0x71
direct3d9 debug: Direct3d9 Device: ATI Radeon HD 4600 Series 4098 38032 0
main debug: resized to 1920x904
main debug: VoutDisplayEvent 'resize' 1920x904
direct3d9 warning: trying surface pixel format: DXA9
direct3d9 debug: selected surface pixel format is DXA9
main debug: VoutDisplayEvent 'resize' 1096x1958
direct3d9 debug: Direct3D9 scene created successfully
direct3d9 debug: Direct3D9 device adapter successfully initialized
main debug: using vout display module "direct3d9"
main debug: original format sz 1920x1088, of (0,0), vsz 1920x1080, 4cc DXA9, sar 1:1, msk r0x0 g0x0 b0x0
main debug: reusing provided vout
main debug: looking for hw decoder module matching "any": 2 candidates
main debug: VoutDisplayEvent 'resize' 1920x904
dxva2 debug: Using Direct3D9 Extended API!
dxva2 debug: Reusing Direct3D9 device
dxva2 debug: CreateDevice succeed
dxva2 debug: OurDirect3DCreateDeviceManager9 Success!
dxva2 debug: obtained IDirect3DDeviceManager9
dxva2 debug: - 'MPEG-2 inverse discrete cosine transform' is supported
dxva2 debug: - 'H.264 variable-length decoder, no film grain technology' is supported
dxva2 debug: - 'H.264 variable-length decoder, no film grain technology, Flash' is supported
dxva2 debug: - 'Unknown decoder 0x6719b6fb-0x5cad-0x4acb-0xb00af3bfdec38727' is supported
dxva2 debug: - 'VC-1 variable-length decoder' is supported
dxva2 debug: - 'Unknown decoder 0xca15d19a-0x2b48-0x43d6-0x979e7a6e9c802ff8' is supported
dxva2 debug: - 'Unknown decoder 0x5b23d46d-0xfa5f-0x4fdc-0xb78a7eb2787942ec' is supported
dxva2 debug: Trying to use 'H.264 variable-length decoder, no film grain technology' as input
dxva2 debug: NV12 is supported for output
dxva2 debug: Using decoder output 'NV12'
dxva2 debug: va_pool_SetupDecoder id 27 1920x1088 count: 22
dxva2 debug: IDirectXVideoAccelerationService_CreateSurface succeed with 22 surfaces (1920x1088)
dxva2 debug: we got 2 decoder configurations
dxva2 debug: configuration[0] ConfigBitstreamRaw 2
dxva2 debug: configuration[1] ConfigBitstreamRaw 2
dxva2 debug: IDirectXVideoDecoderService_CreateVideoDecoder succeed
main debug: using hw decoder module "dxva2"
avcodec info: Using DXVA2 (ATI Radeon HD 4600 Series, vendor ATI(4098), device 38032, revision 0) for hardware decoding
main debug: Received first picture
main debug: Decoder wait done in 513 ms
main debug: inserting 1264 zeroes
mmdevice debug: state changed: 1
main debug: resized to 1920x904
main debug: VoutDisplayEvent 'resize' 1920x904
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: picture might be displayed late (missing 14 ms)
main debug: picture might be displayed late (missing 1 ms)
main warning: picture is too late to be displayed (missing 68 ms)
main warning: picture is too late to be displayed (missing 35 ms)
main debug: picture might be displayed late (missing 1 ms)
main warning: picture is too late to be displayed (missing 20 ms)
main debug: picture might be displayed late (missing 15 ms)
main debug: picture might be displayed late (missing 2 ms)
main debug: picture might be displayed late (missing 1 ms)
main debug: picture might be displayed late (missing 0 ms)
main warning: picture is too late to be displayed (missing 27 ms)
main debug: auto hiding mouse cursor
main debug: auto hiding mouse cursor
main debug: auto hiding mouse cursor
main debug: picture might be displayed late (missing 7 ms)
main debug: auto hiding mouse cursor
main debug: auto hiding mouse cursor
main debug: VoutDisplayEvent 'mouse button' 0 t=8
main debug: VoutDisplayEvent 'mouse button' 0 t=9
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