VLC 2.0.0 RC1 is running slow with MKVs

[Crogge]

I tried today the RC1 of VLC 2.0.0 and noticed that "Full HD" videos are running very laggy with the default settings, also enabling/disabling hardware acceleration and a different render-mode didn't help.

On my default player (VLC 1.1.11) Full HD videos are running without any frameskips and the CPU is less than 10% in use.

Hardware specifications:

Code: Select all

ASUS G73 Notebook Intel i7 720QM CPU 6144MB DDR3-1333MHz RAM ATI Radeon Mobility 5870 1GB DDR5 128GB G.Skill SSD ...

Software:
Windows 7 Home Premium x64

[ultimatebyte]

Same problem here...

Core I7 2600K @ 4,6Ghz, used at 6 to 8% while looking a full HD MKV, with a laggy video... Tried some different video renders : no improvement at all.
Other files seems OK, even HD m2ts.
No problem with previous versions of VLC. I'm gonna forget the VLC RCs i guess...


Did they even test it ?

[Nickie]

same here,

core i7 960 3.5Ghz on x58 chipset
9Go DDR3 triple channel 1600mhz
and Geforce GTX260
W7 64bit

CPU usage is low but VLC is obviously skipping an awful lot of frames on some H.264 videos, 10bit or not most of my 1080p are lagy,
and all my 720p 10bit are unwatchable,

according to VLC stats, there are 1009 lost frames for 3147 shown on a test sample ...

[VLC_help]

What does Tools -> Messages (set Verbosity to 2) complain during playback?

[ultimatebyte]

What does Tools -> Messages (set Verbosity to 2) complain during playback?

In 10 seconds :

Code: Select all

main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 33 ms) main warning: picture is too late to be displayed (missing 183 ms) main warning: picture is too late to be displayed (missing 141 ms) main warning: picture is too late to be displayed (missing 100 ms) main warning: picture is too late to be displayed (missing 58 ms) main warning: picture is too late to be displayed (missing 168 ms) main warning: picture is too late to be displayed (missing 38 ms) main warning: picture is too late to be displayed (missing 328 ms) main warning: picture is too late to be displayed (missing 244 ms) main warning: picture is too late to be displayed (missing 202 ms) main warning: picture is too late to be displayed (missing 161 ms) main warning: picture is too late to be displayed (missing 119 ms) main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 65 ms) main warning: picture is too late to be displayed (missing 23 ms) main warning: picture is too late to be displayed (missing 259 ms) main warning: picture is too late to be displayed (missing 218 ms) main warning: picture is too late to be displayed (missing 93 ms) main warning: picture is too late to be displayed (missing 51 ms) main debug: picture might be displayed late (missing 9 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 183 ms) main warning: picture is too late to be displayed (missing 141 ms) main warning: picture is too late to be displayed (missing 100 ms) main debug: picture might be displayed late (missing 16 ms) main warning: picture is too late to be displayed (missing 50 ms) main debug: picture might be displayed late (missing 8 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 65 ms) main warning: picture is too late to be displayed (missing 23 ms) main warning: picture is too late to be displayed (missing 287 ms) main warning: picture is too late to be displayed (missing 245 ms) main warning: picture is too late to be displayed (missing 203 ms) main warning: picture is too late to be displayed (missing 162 ms) main warning: picture is too late to be displayed (missing 120 ms) main warning: picture is too late to be displayed (missing 259 ms) main warning: picture is too late to be displayed (missing 218 ms) main warning: picture is too late to be displayed (missing 176 ms) main warning: picture is too late to be displayed (missing 134 ms) main warning: picture is too late to be displayed (missing 92 ms) main warning: picture is too late to be displayed (missing 235 ms) main warning: picture is too late to be displayed (missing 193 ms) main warning: picture is too late to be displayed (missing 151 ms) main warning: picture is too late to be displayed (missing 185 ms) main warning: picture is too late to be displayed (missing 143 ms) main debug: picture might be displayed late (missing 18 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 211 ms) main warning: picture is too late to be displayed (missing 170 ms) main warning: picture is too late to be displayed (missing 128 ms) main warning: picture is too late to be displayed (missing 86 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 65 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 211 ms) main warning: picture is too late to be displayed (missing 86 ms) main warning: picture is too late to be displayed (missing 44 ms) main warning: picture is too late to be displayed (missing 154 ms) main warning: picture is too late to be displayed (missing 113 ms) main warning: picture is too late to be displayed (missing 63 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 259 ms) main warning: picture is too late to be displayed (missing 218 ms) main warning: picture is too late to be displayed (missing 176 ms) main warning: picture is too late to be displayed (missing 52 ms) main debug: picture might be displayed late (missing 10 ms) direct3d debug: Created 125x54 texture for OSD main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 26 ms) main warning: picture is too late to be displayed (missing 210 ms) main warning: picture is too late to be displayed (missing 169 ms) main warning: picture is too late to be displayed (missing 127 ms) main warning: picture is too late to be displayed (missing 86 ms) main warning: picture is too late to be displayed (missing 44 ms) main debug: picture might be displayed late (missing 2 ms) main warning: picture is too late to be displayed (missing 260 ms) main warning: picture is too late to be displayed (missing 219 ms) main warning: picture is too late to be displayed (missing 177 ms) main warning: picture is too late to be displayed (missing 135 ms) main warning: picture is too late to be displayed (missing 93 ms) main warning: picture is too late to be displayed (missing 188 ms) main warning: picture is too late to be displayed (missing 146 ms) main warning: picture is too late to be displayed (missing 104 ms) main warning: picture is too late to be displayed (missing 63 ms) main warning: picture is too late to be displayed (missing 21 ms) main warning: picture is too late to be displayed (missing 33 ms) main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 main warning: picture is too late to be displayed (missing 184 ms) main warning: picture is too late to be displayed (missing 101 ms) main warning: picture is too late to be displayed (missing 59 ms) main debug: picture might be displayed late (missing 18 ms) direct3d debug: Created 95x95 texture for OSD main debug: auto hiding mouse cursor

[ultimatebyte]

With GPU decoding enabled, it seems to work perfectly !
Should be enabled by default.

Preferences > input & codecs > *tick* use GPU accelerated decoding



Now it looks OK, just a few strange resizes of the interface while i'm doing nothing, in windowed mode :

Code: Select all

direct3d debug: Created 736x54 texture for OSD direct3d debug: Created 217x111 texture for OSD direct3d debug: Created 519x43 texture for OSD direct3d debug: Created 493x43 texture for OSD direct3d debug: Created 838x101 texture for OSD main debug: auto hiding mouse cursor direct3d debug: Created 517x101 texture for OSD direct3d debug: Created 784x111 texture for OSD direct3d debug: Created 710x111 texture for OSD main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 main debug: VoutDisplayEvent 'double click' qt4 debug: Qt4: Fullscreen state changed qt4 debug: Qt: Entering Fullscreen qt4 debug: Qt4: Fullscreen state changed qt4 debug: Qt4: Fullscreen state changed main debug: VoutDisplayEvent 'resize' 1920x1080 fullscreen direct3d debug: Created 761x101 texture for OSD main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 28 ms) direct3d debug: Created 818x112 texture for OSD direct3d debug: Created 389x54 texture for OSD direct3d debug: Created 321x53 texture for OSD direct3d debug: Created 650x111 texture for OSD main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 direct3d debug: Created 96x96 texture for OSD main debug: auto hiding mouse cursor

Anyway, it works.

Now i'm looking for a way to enable vsync, do you know one ? I'm gonna google it but i'm not sure to find.
Cause for some reasons, my Aero is disabled (so windowed games aren't vsync forced ON and for my 60hz monitor doesn't display 30fps when my main monitor is displaying 120hz), and no aero vsync = no VLC vsync.

[Nickie]

same stuff here:

Code: Select all

main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 104 ms) main warning: picture is too late to be displayed (missing 63 ms) main warning: picture is too late to be displayed (missing 21 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 23 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 65 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: resampling stopped after 15502633 usec (drift: 534) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 109 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 32 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 36 ms) main warning: picture is too late to be displayed (missing 32 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 33 ms) main warning: picture is too late to be displayed (missing 32 ms)

[Jean-Baptiste Kempf]

It seems everyone having this issue is with i7 computers, not with i5 or earlier.

Do you guys have HT?

Can you share ALL the logs, please? From the beginning of the files?

Can you also try to force the threads to 1 in advanced preferences (use search and modify it in FFmpeg section)?

Thanks.

[ultimatebyte]

It seems everyone having this issue is with i7 computers, not with i5 or earlier.

Do you guys have HT?

Can you share ALL the logs, please? From the beginning of the files?

Can you also try to force the threads to 1 in advanced preferences (use search and modify it in FFmpeg section)?

Thanks.

I got HT, I7 2600K, but i guess i saw poeple with I7 and no HT, with this issue.
Which logs do you want ? I copied everything i guess, in "Tools -> Messages (set Verbosity to 2) during playback"

With GPU acceleration, it works well, but it's not enabled by default.
Another problem is i cant see my Freebox V6's playlist... I can get it manually, but then i don't have the TNT channels anymore.

[Jean-Baptiste Kempf]

The Freebox issue is a known one, very simple to fix and will get fixed soon, before the release. Don't worry.

I want ALL the logs!

Can you force threads to 1 too?

[ultimatebyte]

The Freebox issue is a known one, very simple to fix and will get fixed soon, before the release. Don't worry.

I want ALL the logs!

Can you force threads to 1 too?

I tried to change the affinity of VLC.exe in the taskmanager, didn't change anything in the logs.
I'm gonna try without Hyper Threading to see.


I guess here is what you want :

Code: Select all

main debug: adding item `The Da Vinci Code [2006] 1080p.mkv' ( file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv ) qt4 debug: Adding a new MRL to recent ones: file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index -1 main debug: Creating an input for 'The Da Vinci Code [2006] 1080p.mkv' main debug: meta ok for (null), need to fetch art main debug: looking for meta fetcher module: 1 candidate lua debug: Trying Lua scripts in D:\My Documents\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac main debug: using meta fetcher module "lua" main debug: TIMER module_need() : 0.384 ms - Total 0.384 ms / 1 intvls (Avg 0.384 ms) main debug: removing module "lua" main debug: searching art for The Da Vinci Code [2006] 1080p.mkv main debug: looking for art finder module: 2 candidates lua debug: Trying Lua scripts in D:\My Documents\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\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\meta\art\03_lastfm.luac main debug: no art finder module matching "any" could be loaded main debug: TIMER module_need() : 1.188 ms - Total 1.188 ms / 1 intvls (Avg 1.188 ms) main debug: art not found for The Da Vinci Code [2006] 1080p.mkv main debug: processing request item: The Da Vinci Code [2006] 1080p.mkv, node: Playlist, skip: 0 main debug: resyncing on The Da Vinci Code [2006] 1080p.mkv main debug: The Da Vinci Code [2006] 1080p.mkv is at 0 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'The Da Vinci Code [2006] 1080p.mkv' main debug: using timeshift granularity of 50 MiB, in path 'C:\Users\ULTIMA~1\AppData\Local\Temp' main debug: `file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' gives access `file' demux `' path `/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' main debug: creating demux: access='file' demux='' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' file='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for access_demux module: 3 candidates main debug: no access_demux module matching "file" could be loaded main debug: TIMER module_need() : 0.118 ms - Total 0.118 ms / 1 intvls (Avg 0.118 ms) main debug: creating access 'file' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv', path='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for access module: 3 candidates filesystem debug: opening file `E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: using access module "filesystem" main debug: TIMER module_need() : 0.069 ms - Total 0.069 ms / 1 intvls (Avg 0.069 ms) main debug: Using stream method for AStream* main debug: starting pre-buffering main debug: received first data after 0 ms main debug: pre-buffering done 1024 bytes in 0s - 55555 KiB/s main debug: looking for stream_filter module: 4 candidates main debug: no stream_filter module matching "any" could be loaded main debug: TIMER module_need() : 0.041 ms - Total 0.041 ms / 1 intvls (Avg 0.041 ms) main debug: looking for stream_filter module: 1 candidate main debug: using stream_filter module "stream_filter_record" main debug: TIMER module_need() : 0.038 ms - Total 0.038 ms / 1 intvls (Avg 0.038 ms) main debug: creating demux: access='file' demux='' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' file='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for demux module: 55 candidates mkv debug: | + Seek head mkv debug: | | + Seek mkv debug: | - info at 4151 mkv debug: | + Information mkv debug: | | + TimecodeScale=1000000 mkv debug: | | + Muxing Application=libebml v1.2.0 + libmatroska v1.1.0 mkv debug: | | + Writing Application=mkvmerge v4.5.0 ('Speed of Light') built on Feb 1 2011 02:10:32 mkv debug: | | + Duration=10477482 mkv debug: | | + Date=Sat Jun 18 02:26:44 2011 mkv debug: | | + UID=-1481975875 mkv debug: | | + Seek mkv debug: | - tracks at 4306 mkv debug: | + Tracks mkv debug: | | + Track Entry mkv debug: | | | + Track Number=1 mkv debug: | | | + Track UID=1799264687 mkv debug: | | | + Track Type=video mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track MinCache=1 mkv debug: | | | + Track CodecId=V_MPEG4/ISO/AVC mkv debug: | | | + Track CodecPrivate size=47 mkv debug: | | | + Track Default Duration=41708162 mkv debug: | | | + Track Video mkv debug: | | | | + width=1912 mkv debug: | | | | + height=800 mkv debug: | | | | + display width=1912 mkv debug: | | | | + display height=800 mkv debug: | | | + Content Encodings mkv debug: | | | | + Content Encoding mkv debug: | | | | | + Content Compression mkv debug: | | | | | | + Compression Algorithm: 3 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=2 mkv debug: | | | + Track UID=1437643499 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track CodecId=A_AC3 mkv debug: | | | + Track Default Duration=32000000 mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=48000 mkv debug: | | | | + achan=6 mkv debug: | | | + Content Encodings mkv debug: | | | | + Content Encoding mkv debug: | | | | | + Content Compression mkv debug: | | | | | | + Compression Algorithm: 3 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=3 mkv debug: | | | + Track UID=466029310 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track Default=0 mkv debug: | | | + Track CodecId=A_AAC mkv debug: | | | + Track CodecPrivate size=2 qt4 debug: IM: Setting an input mkv debug: | | | + Track Default Duration=21333333 mkv debug: | | | + Track Language=`fre' mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=48000 mkv debug: | | | | + achan=2 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=4 mkv debug: | | | + Track UID=3853522620 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=5 mkv debug: | | | + Track UID=879572357 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Default=0 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=6 mkv debug: | | | + Track UID=3847276972 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Default=0 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | | + Track Language=`fre' mkv debug: | | + Seek mkv debug: | - cues at 9924357273 mkv debug: | + Cues mkv debug: | - loading cues done. mkv debug: | | + Seek mkv debug: | | + Unknown (N7libebml8EbmlVoidE) mkv debug: | - chapters at 5921 mkv debug: | + Chapters mkv debug: | | + EditionEntry mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 2057187589 mkv debug: | | | | + ChapterTimeStart: 0 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 1' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 856239331 mkv debug: | | | | + ChapterTimeStart: 609232944 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 2' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 126309063 mkv debug: | | | | + ChapterTimeStart: 1047462400 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 3' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 711889304 mkv debug: | | | | + ChapterTimeStart: 1861191988 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 4' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1648973968 mkv debug: | | | | + ChapterTimeStart: 2294416444 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 5' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 369383816 mkv debug: | | | | + ChapterTimeStart: 3127832355 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 6' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 977962169 mkv debug: | | | | + ChapterTimeStart: 4003040022 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 7' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 315668100 mkv debug: | | | | + ChapterTimeStart: 4730057988 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 8' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 140914757 mkv debug: | | | | + ChapterTimeStart: 5259003066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 9' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 716910835 mkv debug: | | | | + ChapterTimeStart: 5675419066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 10' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 878960001 mkv debug: | | | | + ChapterTimeStart: 6559302066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 11' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 819092444 mkv debug: | | | | + ChapterTimeStart: 7279354733 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 12' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1172927585 mkv debug: | | | | + ChapterTimeStart: 7683842155 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 13' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1708289669 mkv debug: | | | | + ChapterTimeStart: 8297663688 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 14' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1087947782 mkv debug: | | | | + ChapterTimeStart: 8995861188 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 15' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 313452236 mkv debug: | | | | + ChapterTimeStart: 9451149355 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 16' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | + Void mkv debug: | + Information mkv debug: | + Tracks mkv debug: | + Void mkv debug: | + Chapters mkv debug: | + Void mkv debug: | + Cluster mkv debug: Virtual chapter Chapter 1 from 0 to -1 - mkv debug: Virtual chapter Chapter 2 from 609232944 to -1 - mkv debug: Virtual chapter Chapter 3 from 1047462400 to -1 - mkv debug: Virtual chapter Chapter 4 from 1861191988 to -1 - mkv debug: Virtual chapter Chapter 5 from 2294416444 to -1 - mkv debug: Virtual chapter Chapter 6 from 3127832355 to -1 - mkv debug: Virtual chapter Chapter 7 from 4003040022 to -1 - mkv debug: Virtual chapter Chapter 8 from 4730057988 to -1 - mkv debug: Virtual chapter Chapter 9 from 5259003066 to -1 - mkv debug: Virtual chapter Chapter 10 from 5675419066 to -1 - mkv debug: Virtual chapter Chapter 11 from 6559302066 to -1 - mkv debug: Virtual chapter Chapter 12 from 7279354733 to -1 - mkv debug: Virtual chapter Chapter 13 from 7683842155 to -1 - mkv debug: Virtual chapter Chapter 14 from 8297663688 to -1 - mkv debug: Virtual chapter Chapter 15 from 8995861188 to -1 - mkv debug: Virtual chapter Chapter 16 from 9451149355 to -1 - mkv debug: Virtual chapter from 0 to -1 - mkv debug: found 6 es main debug: selecting program id=0 mkv debug: Starting the UI Hook main debug: using demux module "mkv" main debug: TIMER module_need() : 12.348 ms - Total 12.348 ms / 1 intvls (Avg 12.348 ms) main debug: looking for a subtitle file in E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre main debug: looking for decoder module: 31 candidates avcodec debug: libavcodec initialized (interface 0x352400) avcodec debug: trying to use direct rendering avcodec debug: allowing 9 thread(s) for decoding avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started avcodec debug: using frame thread mode with 9 threads main debug: using decoder module "avcodec" main debug: TIMER module_need() : 3.808 ms - Total 3.808 ms / 1 intvls (Avg 3.808 ms) main debug: looking for decoder module: 31 candidates main debug: using decoder module "a52" main debug: TIMER module_need() : 0.157 ms - Total 0.157 ms / 1 intvls (Avg 0.157 ms) main debug: looking for decoder module: 31 candidates avcodec debug: libavcodec already initialized avcodec debug: codec not found (Text subtitles with various tags) subsdec debug: trying demuxer-specified character encoding: UTF-8 main debug: using decoder module "subsdec" main debug: TIMER module_need() : 0.727 ms - Total 0.727 ms / 1 intvls (Avg 0.727 ms) main debug: idx1=-1(en) idx2=-1(en) main debug: idx1=-1(fr) idx2=-1(en) main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in D:\My Documents\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 module matching "any" could be loaded main debug: TIMER module_need() : 0.453 ms - Total 0.453 ms / 1 intvls (Avg 0.453 ms) main debug: `file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' successfully opened main debug: Buffering 0% main debug: Buffering 0% main debug: Buffering 0% a52 debug: A/52 channels:6 samplerate:48000 bitrate:448000 main debug: creating audio output main debug: Buffering 56% main debug: Buffering 85% main debug: Stream buffering done (341 ms in 0 ms) main debug: looking for audio output module: 2 candidates aout_directx debug: Opening DirectSound Audio Output main debug: looking for text renderer module: 2 candidates freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 0.646 ms - Total 0.646 ms / 1 intvls (Avg 0.646 ms) main debug: looking for video filter2 module: 18 candidates swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality) main debug: using video filter2 module "swscale" main debug: TIMER module_need() : 0.497 ms - Total 0.497 ms / 1 intvls (Avg 0.497 ms) main debug: looking for video filter2 module: 18 candidates yuvp debug: YUVP to YUVA converter main debug: using video filter2 module "yuvp" main debug: TIMER module_need() : 0.990 ms - Total 0.990 ms / 1 intvls (Avg 0.990 ms) aout_directx debug: found device: Primary Sound Driver aout_directx debug: found device: Multichannel (M-Audio ProFire 2626) main debug: Deinterlacing available main debug: deinterlace -1, mode blend, is_needed 0 main debug: Opening vout display wrapper main debug: looking for vout display module: 6 candidates aout_directx debug: device supports 5.1 channels aout_directx debug: device supports 4 channels aout_directx debug: device supports 2 channels aout_directx debug: device supports 1 channel aout_directx debug: Windows says your SpeakerConfig is stereo aout_directx debug: creating DirectSoundThread main debug: using audio output module "aout_directx" main debug: TIMER module_need() : 11.720 ms - Total 11.720 ms / 1 intvls (Avg 11.720 ms) main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes main debug: mixer 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates aout_directx debug: DirectSoundThread ready audio_format debug: f32l->s16l, bits per sample: 32->16 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 1.595 ms - Total 1.595 ms / 1 intvls (Avg 1.595 ms) main debug: conversion pipeline completed main debug: looking for audio mixer module: 2 candidates main debug: using audio mixer module "float32_mixer" main debug: TIMER module_need() : 0.113 ms - Total 0.113 ms / 1 intvls (Avg 0.113 ms) main debug: input 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/1792 bytes main debug: looking for audio filter module: 1 candidate 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: TIMER module_need() : 0.142 ms - Total 0.142 ms / 1 intvls (Avg 0.142 ms) main debug: filter(s) 'a52 '->'f32l' 48000 Hz->48000 Hz 3F2R/LFE->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "a52tofloat32" main debug: TIMER module_need() : 0.226 ms - Total 0.226 ms / 1 intvls (Avg 0.226 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 52800 Hz->48000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.102 ms - Total 0.102 ms / 1 intvls (Avg 0.102 ms) main debug: conversion pipeline completed main debug: End of audio preroll direct3d debug: creating Vout EventThread direct3d debug: DirectXCreateWindow main debug: looking for vout window hwnd module: 2 candidates qt4 debug: requesting video... qt4 debug: Title 1 qt4 debug: Chapter: 16 qt4 debug: Video was requested 0, 0 main debug: using vout window hwnd module "qt4" main debug: TIMER module_need() : 140.890 ms - Total 140.890 ms / 1 intvls (Avg 140.890 ms) direct3d debug: created video sub-window direct3d debug: Vout EventThread running direct3d debug: disabling screen saver main debug: VoutDisplayEvent 'resize' 1928x838 window direct3d warning: trying surface pixel format: YV12 direct3d debug: selected surface pixel format is YV12 direct3d debug: Using D3DTEXF_LINEAR for minification direct3d debug: Using D3DTEXF_LINEAR for magnification direct3d debug: Direct3D scene created successfully direct3d debug: Direct3D device adapter successfully initialized main debug: using vout display module "direct3d" main debug: TIMER module_need() : 218.025 ms - Total 218.025 ms / 1 intvls (Avg 218.025 ms) main debug: original format sz 1912x800, of (0,0), vsz 1912x800, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: removing module "freetype" main debug: looking for text renderer module: 2 candidates main debug: VoutDisplayEvent 'resize' 1912x800 window freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 0.500 ms - Total 0.500 ms / 1 intvls (Avg 0.500 ms) avcodec debug: using direct rendering main debug: Decoder buffering done in 230 ms main warning: PTS is out of range (-9991), dropping buffer main debug: End of video preroll direct3d debug: Created 839x54 texture for OSD main debug: Post-processing available main warning: picture is too late to be displayed (missing 25 ms) main debug: audio output is starving (-159428), playing silence main debug: picture might be displayed late (missing 16 ms) main debug: picture might be displayed late (missing 16 ms) main debug: picture might be displayed late (missing 16 ms) main debug: picture might be displayed late (missing 17 ms) main debug: auto hiding mouse cursor main debug: picture might be displayed late (missing 18 ms) main debug: picture might be displayed late (missing 19 ms) main debug: picture might be displayed late (missing 19 ms) main warning: picture is too late to be displayed (missing 20 ms) main warning: picture is too late to be displayed (missing 20 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 26 ms) main warning: picture is too late to be displayed (missing 98 ms) main warning: picture is too late to be displayed (missing 56 ms) main debug: picture might be displayed late (missing 14 ms) main warning: picture is too late to be displayed (missing 99 ms) main warning: picture is too late to be displayed (missing 57 ms) main debug: picture might be displayed late (missing 15 ms) main warning: picture is too late to be displayed (missing 27 ms) main warning: picture is too late to be displayed (missing 98 ms) main warning: picture is too late to be displayed (missing 56 ms) main debug: picture might be displayed late (missing 15 ms) main warning: picture is too late to be displayed (missing 171 ms) main warning: picture is too late to be displayed (missing 129 ms) main warning: picture is too late to be displayed (missing 88 ms) main warning: picture is too late to be displayed (missing 46 ms) main warning: picture is too late to be displayed (missing 147 ms) main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 197 ms) main warning: picture is too late to be displayed (missing 101 ms) main warning: picture is too late to be displayed (missing 59 ms) main debug: picture might be displayed late (missing 18 ms) main warning: picture is too late to be displayed (missing 102 ms) main warning: picture is too late to be displayed (missing 60 ms) main debug: picture might be displayed late (missing 19 ms) main warning: picture is too late to be displayed (missing 104 ms) main warning: picture is too late to be displayed (missing 62 ms) main warning: picture is too late to be displayed (missing 20 ms) main warning: picture is too late to be displayed (missing 103 ms) main warning: picture is too late to be displayed (missing 61 ms) main debug: picture might be displayed late (missing 19 ms) main warning: picture is too late to be displayed (missing 29 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 178 ms) main warning: picture is too late to be displayed (missing 136 ms) main warning: picture is too late to be displayed (missing 95 ms) main warning: picture is too late to be displayed (missing 53 ms) main warning: picture is too late to be displayed (missing 235 ms) main warning: picture is too late to be displayed (missing 193 ms) main warning: picture is too late to be displayed (missing 152 ms) main warning: picture is too late to be displayed (missing 110 ms) main warning: picture is too late to be displayed (missing 68 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 105 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 105 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 105 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 106 ms) main warning: picture is too late to be displayed (missing 64 ms) main warning: picture is too late to be displayed (missing 22 ms) main warning: picture is too late to be displayed (missing 181 ms) main warning: picture is too late to be displayed (missing 140 ms) main warning: picture is too late to be displayed (missing 99 ms) main warning: picture is too late to be displayed (missing 57 ms) main debug: picture might be displayed late (missing 15 ms) main warning: picture is too late to be displayed (missing 47 ms) main debug: picture might be displayed late (missing 6 ms) main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 109 ms) main warning: picture is too late to be displayed (missing 68 ms) main warning: picture is too late to be displayed (missing 26 ms) main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 main warning: picture is too late to be displayed (missing 183 ms) main warning: picture is too late to be displayed (missing 142 ms) main warning: picture is too late to be displayed (missing 100 ms) main warning: picture is too late to be displayed (missing 58 ms) main debug: picture might be displayed late (missing 17 ms) main warning: picture is too late to be displayed (missing 50 ms) main debug: picture might be displayed late (missing 8 ms) main warning: picture is too late to be displayed (missing 109 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 109 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 101 ms) main warning: picture is too late to be displayed (missing 59 ms) main warning: picture is too late to be displayed (missing 244 ms) main warning: picture is too late to be displayed (missing 202 ms) main warning: picture is too late to be displayed (missing 161 ms) main warning: picture is too late to be displayed (missing 119 ms) main warning: picture is too late to be displayed (missing 77 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 24 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 25 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) direct3d debug: Created 95x95 texture for OSD main debug: auto hiding mouse cursor main debug: auto hiding mouse cursor

No comment about the test video

[ultimatebyte]

Here is what it makes with HT diabled, and afinity set to core 0 (exactly the same i guess...) :

Code: Select all

main debug: adding item `The Da Vinci Code [2006] 1080p.mkv' ( file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv ) qt4 debug: Adding a new MRL to recent ones: file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv main debug: rebuilding array of current - root Playlist main debug: rebuild done - 1 items, index -1 main debug: Creating an input for 'The Da Vinci Code [2006] 1080p.mkv' main debug: meta ok for (null), need to fetch art main debug: looking for meta fetcher module: 1 candidate lua debug: Trying Lua scripts in D:\My Documents\AppData\Roaming\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac main debug: using meta fetcher module "lua" main debug: TIMER module_need() : 3.739 ms - Total 3.739 ms / 1 intvls (Avg 3.739 ms) main debug: removing module "lua" main debug: searching art for The Da Vinci Code [2006] 1080p.mkv main debug: looking for art finder module: 2 candidates lua debug: Trying Lua scripts in D:\My Documents\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\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\meta\art\03_lastfm.luac main debug: no art finder module matching "any" could be loaded main debug: TIMER module_need() : 6.944 ms - Total 6.944 ms / 1 intvls (Avg 6.944 ms) main debug: art not found for The Da Vinci Code [2006] 1080p.mkv main debug: processing request item: The Da Vinci Code [2006] 1080p.mkv, node: Playlist, skip: 0 main debug: resyncing on The Da Vinci Code [2006] 1080p.mkv main debug: The Da Vinci Code [2006] 1080p.mkv is at 0 main debug: starting playback of the new playlist item main debug: creating new input thread main debug: Creating an input for 'The Da Vinci Code [2006] 1080p.mkv' qt4 debug: IM: Setting an input main debug: using timeshift granularity of 50 MiB, in path 'C:\Users\ULTIMA~1\AppData\Local\Temp' main debug: `file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' gives access `file' demux `' path `/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' main debug: creating demux: access='file' demux='' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' file='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for access_demux module: 3 candidates main debug: no access_demux module matching "file" could be loaded main debug: TIMER module_need() : 0.122 ms - Total 0.122 ms / 1 intvls (Avg 0.122 ms) main debug: creating access 'file' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv', path='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for access module: 3 candidates filesystem debug: opening file `E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: using access module "filesystem" main debug: TIMER module_need() : 13.953 ms - Total 13.953 ms / 1 intvls (Avg 13.953 ms) main debug: Using stream method for AStream* main debug: starting pre-buffering main debug: received first data after 0 ms main debug: pre-buffering done 1024 bytes in 0s - 1225 KiB/s main debug: looking for stream_filter module: 4 candidates main debug: no stream_filter module matching "any" could be loaded main debug: TIMER module_need() : 1.889 ms - Total 1.889 ms / 1 intvls (Avg 1.889 ms) main debug: looking for stream_filter module: 1 candidate main debug: using stream_filter module "stream_filter_record" main debug: TIMER module_need() : 1.758 ms - Total 1.758 ms / 1 intvls (Avg 1.758 ms) main debug: creating demux: access='file' demux='' location='/E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' file='E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre\The Da Vinci Code [2006] 1080p.mkv' main debug: looking for demux module: 55 candidates mkv debug: | + Seek head mkv debug: | | + Seek mkv debug: | - info at 4151 mkv debug: | + Information mkv debug: | | + TimecodeScale=1000000 mkv debug: | | + Muxing Application=libebml v1.2.0 + libmatroska v1.1.0 mkv debug: | | + Writing Application=mkvmerge v4.5.0 ('Speed of Light') built on Feb 1 2011 02:10:32 mkv debug: | | + Duration=10477482 mkv debug: | | + Date=Sat Jun 18 02:26:44 2011 mkv debug: | | + UID=-1481975875 mkv debug: | | + Seek mkv debug: | - tracks at 4306 mkv debug: | + Tracks mkv debug: | | + Track Entry mkv debug: | | | + Track Number=1 mkv debug: | | | + Track UID=1799264687 mkv debug: | | | + Track Type=video mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track MinCache=1 mkv debug: | | | + Track CodecId=V_MPEG4/ISO/AVC mkv debug: | | | + Track CodecPrivate size=47 mkv debug: | | | + Track Default Duration=41708162 mkv debug: | | | + Track Video mkv debug: | | | | + width=1912 mkv debug: | | | | + height=800 mkv debug: | | | | + display width=1912 mkv debug: | | | | + display height=800 mkv debug: | | | + Content Encodings mkv debug: | | | | + Content Encoding mkv debug: | | | | | + Content Compression mkv debug: | | | | | | + Compression Algorithm: 3 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=2 mkv debug: | | | + Track UID=1437643499 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track CodecId=A_AC3 mkv debug: | | | + Track Default Duration=32000000 mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=48000 mkv debug: | | | | + achan=6 mkv debug: | | | + Content Encodings mkv debug: | | | | + Content Encoding mkv debug: | | | | | + Content Compression mkv debug: | | | | | | + Compression Algorithm: 3 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=3 mkv debug: | | | + Track UID=466029310 mkv debug: | | | + Track Type=audio mkv debug: | | | + Track Default=0 mkv debug: | | | + Track CodecId=A_AAC mkv debug: | | | + Track CodecPrivate size=2 mkv debug: | | | + Track Default Duration=21333333 mkv debug: | | | + Track Language=`fre' mkv debug: | | | + Track Audio mkv debug: | | | | + afreq=48000 mkv debug: | | | | + achan=2 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=4 mkv debug: | | | + Track UID=3853522620 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=5 mkv debug: | | | + Track UID=879572357 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Default=0 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | + Track Entry mkv debug: | | | + Track Number=6 mkv debug: | | | + Track UID=3847276972 mkv debug: | | | + Track Type=subtitle mkv debug: | | | + Track Default=0 mkv debug: | | | + Track Lacing=0 mkv debug: | | | + Track CodecId=S_TEXT/UTF8 mkv debug: | | | + Track Language=`fre' mkv debug: | | + Seek mkv debug: | - cues at 9924357273 mkv debug: | + Cues mkv debug: | - loading cues done. mkv debug: | | + Seek mkv debug: | | + Unknown (N7libebml8EbmlVoidE) mkv debug: | - chapters at 5921 mkv debug: | + Chapters mkv debug: | | + EditionEntry mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 2057187589 mkv debug: | | | | + ChapterTimeStart: 0 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 1' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 856239331 mkv debug: | | | | + ChapterTimeStart: 609232944 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 2' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 126309063 mkv debug: | | | | + ChapterTimeStart: 1047462400 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 3' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 711889304 mkv debug: | | | | + ChapterTimeStart: 1861191988 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 4' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1648973968 mkv debug: | | | | + ChapterTimeStart: 2294416444 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 5' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 369383816 mkv debug: | | | | + ChapterTimeStart: 3127832355 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 6' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 977962169 mkv debug: | | | | + ChapterTimeStart: 4003040022 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 7' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 315668100 mkv debug: | | | | + ChapterTimeStart: 4730057988 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 8' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 140914757 mkv debug: | | | | + ChapterTimeStart: 5259003066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 9' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 716910835 mkv debug: | | | | + ChapterTimeStart: 5675419066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 10' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 878960001 mkv debug: | | | | + ChapterTimeStart: 6559302066 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 11' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 819092444 mkv debug: | | | | + ChapterTimeStart: 7279354733 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 12' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1172927585 mkv debug: | | | | + ChapterTimeStart: 7683842155 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 13' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1708289669 mkv debug: | | | | + ChapterTimeStart: 8297663688 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 14' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 1087947782 mkv debug: | | | | + ChapterTimeStart: 8995861188 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 15' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | | | + ChapterAtom (level=0) mkv debug: | | | | + ChapterUID: 313452236 mkv debug: | | | | + ChapterTimeStart: 9451149355 mkv debug: | | | | + ChapterFlagHidden: no mkv debug: | | | | + ChapterDisplay mkv debug: | | | | | + ChapterString 'Chapter 16' mkv debug: | | | | | + ChapterLanguage 'eng' mkv debug: | + Void mkv debug: | + Information mkv debug: | + Tracks mkv debug: | + Void mkv debug: | + Chapters mkv debug: | + Void mkv debug: | + Cluster mkv debug: Virtual chapter Chapter 1 from 0 to -1 - mkv debug: Virtual chapter Chapter 2 from 609232944 to -1 - mkv debug: Virtual chapter Chapter 3 from 1047462400 to -1 - mkv debug: Virtual chapter Chapter 4 from 1861191988 to -1 - mkv debug: Virtual chapter Chapter 5 from 2294416444 to -1 - mkv debug: Virtual chapter Chapter 6 from 3127832355 to -1 - mkv debug: Virtual chapter Chapter 7 from 4003040022 to -1 - mkv debug: Virtual chapter Chapter 8 from 4730057988 to -1 - mkv debug: Virtual chapter Chapter 9 from 5259003066 to -1 - mkv debug: Virtual chapter Chapter 10 from 5675419066 to -1 - mkv debug: Virtual chapter Chapter 11 from 6559302066 to -1 - mkv debug: Virtual chapter Chapter 12 from 7279354733 to -1 - mkv debug: Virtual chapter Chapter 13 from 7683842155 to -1 - mkv debug: Virtual chapter Chapter 14 from 8297663688 to -1 - mkv debug: Virtual chapter Chapter 15 from 8995861188 to -1 - mkv debug: Virtual chapter Chapter 16 from 9451149355 to -1 - mkv debug: Virtual chapter from 0 to -1 - mkv debug: found 6 es main debug: selecting program id=0 mkv debug: Starting the UI Hook main debug: using demux module "mkv" main debug: TIMER module_need() : 44.629 ms - Total 44.629 ms / 1 intvls (Avg 44.629 ms) main debug: looking for a subtitle file in E:\Videos\Movies\1080p\The Da Vinci Code [2006] 1080p Eng + Fre main debug: looking for decoder module: 31 candidates avcodec debug: libavcodec initialized (interface 0x352400) avcodec debug: trying to use direct rendering avcodec debug: allowing 5 thread(s) for decoding avcodec debug: ffmpeg codec (H264 - MPEG-4 AVC (part 10)) started avcodec debug: using frame thread mode with 5 threads main debug: using decoder module "avcodec" main debug: TIMER module_need() : 3.288 ms - Total 3.288 ms / 1 intvls (Avg 3.288 ms) qt4 debug: Title 1 qt4 debug: Chapter: 16 main debug: looking for decoder module: 31 candidates main debug: using decoder module "a52" main debug: TIMER module_need() : 0.154 ms - Total 0.154 ms / 1 intvls (Avg 0.154 ms) main debug: looking for decoder module: 31 candidates avcodec debug: libavcodec already initialized avcodec debug: codec not found (Text subtitles with various tags) subsdec debug: trying demuxer-specified character encoding: UTF-8 main debug: using decoder module "subsdec" main debug: TIMER module_need() : 0.712 ms - Total 0.712 ms / 1 intvls (Avg 0.712 ms) main debug: idx1=-1(en) idx2=-1(en) main debug: idx1=-1(fr) idx2=-1(en) main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in D:\My Documents\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 module matching "any" could be loaded main debug: TIMER module_need() : 0.437 ms - Total 0.437 ms / 1 intvls (Avg 0.437 ms) main debug: `file:///E:/Videos/Movies/1080p/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p%20Eng%20+%20Fre/The%20Da%20Vinci%20Code%20%5B2006%5D%201080p.mkv' successfully opened main debug: Buffering 0% main debug: Buffering 0% a52 debug: A/52 channels:6 samplerate:48000 bitrate:448000 main debug: creating audio output main debug: looking for audio output module: 2 candidates aout_directx debug: Opening DirectSound Audio Output main debug: Buffering 0% main debug: Buffering 56% main debug: Buffering 85% main debug: Stream buffering done (341 ms in 1 ms) main debug: looking for text renderer module: 2 candidates aout_directx debug: found device: Primary Sound Driver aout_directx debug: found device: Multichannel (M-Audio ProFire 2626) freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 1.291 ms - Total 1.291 ms / 1 intvls (Avg 1.291 ms) main debug: looking for video filter2 module: 18 candidates swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality) main debug: using video filter2 module "swscale" main debug: TIMER module_need() : 0.486 ms - Total 0.486 ms / 1 intvls (Avg 0.486 ms) main debug: looking for video filter2 module: 18 candidates yuvp debug: YUVP to YUVA converter main debug: using video filter2 module "yuvp" main debug: TIMER module_need() : 0.896 ms - Total 0.896 ms / 1 intvls (Avg 0.896 ms) main debug: Deinterlacing available main debug: deinterlace -1, mode blend, is_needed 0 main debug: Opening vout display wrapper main debug: looking for vout display module: 6 candidates direct3d debug: creating Vout EventThread direct3d debug: DirectXCreateWindow main debug: looking for vout window hwnd module: 2 candidates qt4 debug: requesting video... qt4 debug: Video was requested 0, 0 main debug: using vout window hwnd module "qt4" main debug: TIMER module_need() : 9.403 ms - Total 9.403 ms / 1 intvls (Avg 9.403 ms) direct3d debug: created video sub-window direct3d debug: Vout EventThread running direct3d debug: disabling screen saver aout_directx debug: device supports 5.1 channels aout_directx debug: device supports 4 channels aout_directx debug: device supports 2 channels aout_directx debug: device supports 1 channel aout_directx debug: Windows says your SpeakerConfig is stereo aout_directx debug: creating DirectSoundThread aout_directx debug: DirectSoundThread ready main debug: using audio output module "aout_directx" main debug: TIMER module_need() : 93.261 ms - Total 93.261 ms / 1 intvls (Avg 93.261 ms) main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes main debug: mixer 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates audio_format debug: f32l->s16l, bits per sample: 32->16 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 1.017 ms - Total 1.017 ms / 1 intvls (Avg 1.017 ms) main debug: conversion pipeline completed main debug: looking for audio mixer module: 2 candidates main debug: using audio mixer module "float32_mixer" main debug: TIMER module_need() : 0.106 ms - Total 0.106 ms / 1 intvls (Avg 0.106 ms) main debug: input 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/1792 bytes main debug: looking for audio filter module: 1 candidate 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: TIMER module_need() : 0.137 ms - Total 0.137 ms / 1 intvls (Avg 0.137 ms) main debug: filter(s) 'a52 '->'f32l' 48000 Hz->48000 Hz 3F2R/LFE->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "a52tofloat32" main debug: TIMER module_need() : 0.217 ms - Total 0.217 ms / 1 intvls (Avg 0.217 ms) main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo main debug: conversion pipeline completed main debug: filter(s) 'f32l'->'f32l' 52800 Hz->48000 Hz Stereo->Stereo main debug: looking for audio filter module: 14 candidates main debug: using audio filter module "samplerate" main debug: TIMER module_need() : 0.132 ms - Total 0.132 ms / 1 intvls (Avg 0.132 ms) main debug: conversion pipeline completed main debug: End of audio preroll main debug: VoutDisplayEvent 'resize' 1928x838 window direct3d warning: trying surface pixel format: YV12 direct3d debug: selected surface pixel format is YV12 direct3d debug: Using D3DTEXF_LINEAR for minification direct3d debug: Using D3DTEXF_LINEAR for magnification direct3d debug: Direct3D scene created successfully direct3d debug: Direct3D device adapter successfully initialized main debug: using vout display module "direct3d" main debug: TIMER module_need() : 108.934 ms - Total 108.934 ms / 1 intvls (Avg 108.934 ms) main debug: original format sz 1912x800, of (0,0), vsz 1912x800, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: removing module "freetype" main debug: looking for text renderer module: 2 candidates freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 0.459 ms - Total 0.459 ms / 1 intvls (Avg 0.459 ms) avcodec debug: using direct rendering main debug: End of video preroll main debug: VoutDisplayEvent 'resize' 1912x800 window main debug: Received first picture direct3d debug: Created 839x54 texture for OSD main debug: Post-processing available main debug: Decoder buffering done in 205 ms main warning: PTS is out of range (-9992), dropping buffer main warning: audio output out of sync, adjusting dates (66766 us) main warning: picture is too late to be displayed (missing 42 ms) main debug: picture might be displayed late (missing 1 ms) main warning: not synchronized (66767 us), resampling main warning: buffer too late (65787), up-sampling main debug: audio output is starving (-199959), playing silence main debug: auto hiding mouse cursor main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 main warning: picture is too late to be displayed (missing 38 ms) main warning: picture is too late to be displayed (missing 37 ms) main warning: picture is too late to be displayed (missing 34 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 117 ms) main warning: picture is too late to be displayed (missing 76 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 debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 38 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 117 ms) main warning: picture is too late to be displayed (missing 76 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: resampling stopped after 14192045 usec (drift: 692) main warning: picture is too late to be displayed (missing 109 ms) main warning: picture is too late to be displayed (missing 68 ms) main warning: picture is too late to be displayed (missing 26 ms) main warning: picture is too late to be displayed (missing 38 ms) main warning: picture is too late to be displayed (missing 45 ms) main debug: picture might be displayed late (missing 3 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 115 ms) main warning: picture is too late to be displayed (missing 74 ms) main warning: picture is too late to be displayed (missing 113 ms) main warning: picture is too late to be displayed (missing 71 ms) main warning: picture is too late to be displayed (missing 30 ms) main warning: picture is too late to be displayed (missing 32 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 43 ms) main debug: picture might be displayed late (missing 1 ms) main warning: picture is too late to be displayed (missing 32 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 185 ms) main warning: picture is too late to be displayed (missing 143 ms) main warning: picture is too late to be displayed (missing 187 ms) main warning: picture is too late to be displayed (missing 145 ms) main warning: picture is too late to be displayed (missing 103 ms) main warning: picture is too late to be displayed (missing 37 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 32 ms) main debug: VoutDisplayEvent 'mouse button' 0 t=8 main debug: VoutDisplayEvent 'mouse button' 0 t=9 main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 31 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 107 ms) main warning: picture is too late to be displayed (missing 65 ms) main warning: picture is too late to be displayed (missing 24 ms) main debug: auto hiding mouse cursor main warning: audio output out of sync, adjusting dates (-45691 us) main warning: not synchronized (-45690 us), resampling main warning: buffer too early (-46382), down-sampling main warning: picture is too late to be displayed (missing 31 ms) mkv debug: seek request to -1 (0.136000%) mkv debug: seek got 1424547000 (13%) main debug: auto hiding mouse cursor main debug: Buffering 0% main debug: Buffering 1% main debug: Buffering 4% main debug: Buffering 25% main debug: Buffering 41% main debug: Buffering 50% main debug: Buffering 75% main debug: Buffering 78% main debug: Buffering 99% main debug: Stream buffering done (797 ms in 21 ms) qt4 debug: Title 1 qt4 debug: Chapter: 16 qt4 debug: Title 1 qt4 debug: Chapter: 16 main debug: Decoder buffering done in 179 ms main debug: End of audio preroll main debug: audio output is starving (-360382), playing silence main debug: End of video preroll main warning: picture is too late to be displayed (missing 99 ms) main warning: picture is too late to be displayed (missing 70 ms) main warning: picture is too late to be displayed (missing 42 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 debug: looking for xml reader module: 1 candidate main debug: using xml reader module "xml" main debug: TIMER module_need() : 0.137 ms - Total 0.137 ms / 1 intvls (Avg 0.137 ms) direct3d debug: Created 100x45 texture for OSD main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 66 ms) main warning: picture is too late to be displayed (missing 25 ms) main warning: resampling stopped after 6733639 usec (drift: -7437) main warning: picture is too late to be displayed (missing 34 ms) direct3d debug: Created 632x53 texture for OSD main warning: picture is too late to be displayed (missing 34 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 33 ms) direct3d debug: Created 443x43 texture for OSD main warning: picture is too late to be displayed (missing 31 ms) main warning: picture is too late to be displayed (missing 116 ms) main warning: picture is too late to be displayed (missing 75 ms) main warning: picture is too late to be displayed (missing 35 ms) main warning: picture is too late to be displayed (missing 32 ms) main warning: picture is too late to be displayed (missing 108 ms) main warning: picture is too late to be displayed (missing 67 ms) main warning: picture is too late to be displayed (missing 25 ms) main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 44 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 32 ms) main warning: picture is too late to be displayed (missing 47 ms) main debug: picture might be displayed late (missing 6 ms) direct3d debug: Created 489x102 texture for OSD main debug: auto hiding mouse cursor main debug: auto hiding mouse cursor main warning: picture is too late to be displayed (missing 35 ms) direct3d debug: Created 95x95 texture for OSD main debug: auto hiding mouse cursor

[Jean-Baptiste Kempf]

avcodec debug: using frame thread mode with 9 threads

avcodec debug: using frame thread mode with 5 threads

Is it a quad core?

Can you put 4 threads in the preferences?

[ultimatebyte]

avcodec debug: using frame thread mode with 9 threads

avcodec debug: using frame thread mode with 5 threads

Is it a quad core?

Can you put 4 threads in the preferences?

Would be strange that it changes anything, as the CPU is under 8%, wich isn't even one core with HT on.

Yes, i said it was a 2600K, so it's a quadcore with HT, that's why i tried disabling it.
Anyway, if you want it, where is the option to set the number of threads ?

[degarb]

I posted lagginess with single core and 420p video (which I use over 480, for size and encoding time).

I am wondering, before reinstalling 2.0 again, do all windows computers (or linux) have gpu ability. Is 2.0 only going to work on expensive, upper end computers with latest specs? Or will it work on the ubiquitous and cheap, new and used, single core machines (p3 and up)--so an entire family can enjoy video on their own computer, not just the parents or working teen that lives at home.

[VLC_help]

If you have HT enabled CPU, like Intel Atom or 2600K or similar, then go to Tools -> Preferences (Show settings: All) and Input / Codecs -> Video codecs -> FFmpeg, set threads via there. Save and restart VLC.

[ultimatebyte]

If you have HT enabled CPU, like Intel Atom or 2600K or similar, then go to Tools -> Preferences (Show settings: All) and Input / Codecs -> Video codecs -> FFmpeg, set threads via there. Save and restart VLC.

Don't know if it's really a mater of HT or not cause i tried without it and didn't work neither.


But your solution works well ! With one thread it works well !
Actually : If i set to 1 or 2 threads : no errors in log
If i set to 3 or 4 : errors comes up.

Good luck to fix it by default.

(sorry for my english, i'm french...)

[Jean-Baptiste Kempf]

Ok, so there is clearly an issue of threads with HT CPUs.

[ultimatebyte]

Ok, so there is clearly an issue of threads with HT CPUs.

Why with HT CPUs ?!!

I just said with HT Off the problem was the same... I actually did the last thread test with HT off...

It seems to be a problem with > 2 cores CPUs !

[Jean-Baptiste Kempf]

I think that even if you turn HT off, VLC misdetects it.

I have tested with a Core 2 Quad without issue so far. Same as a quad Core i5. I have no more clues and ideas, to be honest.

[Crogge]

Logs with default VLC configuration:

Code: Select all

avcodec error: more than 5 seconds of late video -> dropping frame (computer too slow ?) main warning: picture is too late to be displayed (missing 609 ms) main warning: picture is too late to be displayed (missing 594 ms) main warning: picture is too late to be displayed (missing 732 ms) main warning: picture is too late to be displayed (missing 795 ms) main warning: picture is too late to be displayed (missing 619 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 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 61 ms) main warning: picture is too late to be displayed (missing 20 ms) main warning: picture is too late to be displayed (missing 28 ms) main warning: picture is too late to be displayed (missing 29 ms) main warning: picture is too late to be displayed (missing 103 ms) main warning: picture is too late to be displayed (missing 62 ms)

Movie information:

Code: Select all

Codec: H264 - MPEG-4 AVC (AVC1) Resolution: 1920x800 FPS: 23.97 Color: 4:2:0 YUV Audio: A52 aka AC3

After I enabled "GPU acceleration" the picture was running more smooth, but it is still "laggy" every 20-30 sec I would say that the picture has maybe 12 instead of 23 FPS. No messages are appearing in the DEBUG logs though! This issues are not appearing with other media players.

The GPU / CPU load is pretty low in that time, I only noticed that my GPU is not going into performance mode. It is running at 400/1000MHz instead of 700/1000MHz, but I can't imagine that it is causing the lags because the load on the GPU is low even underclocked.

...

It seems to be a problem with > 2 cores CPUs !

That would be a problem in year 2012 because most PCs/NBs have a CPU nowadays with 2 cores or more.

[ultimatebyte]

I think that even if you turn HT off, VLC misdetects it.

I have tested with a Core 2 Quad without issue so far. Same as a quad Core i5. I have no more clues and ideas, to be honest.

Mh i see... Do you want me to try on my GF's computer ? Quite similar configuration as me, but 2500K (so i5 quadcore with no HT) and no SSD, with AMD GPU (HD5870 VS HD6970 for me) and same version of Catalyst.

[Jean-Baptiste Kempf]

That would be really cool.

[ultimatebyte]

I think that even if you turn HT off, VLC misdetects it.

I have tested with a Core 2 Quad without issue so far. Same as a quad Core i5. I have no more clues and ideas, to be honest.

You were right, it works perfectly smooth with the same movie (read over gigabit network) on the 2500K computer, so no HT.
So there is a problem with HT CPUs, even if HT if disabled.

Good luck to patch it

[Jean-Baptiste Kempf]

I think that even if you turn HT off, VLC misdetects it.

I have tested with a Core 2 Quad without issue so far. Same as a quad Core i5. I have no more clues and ideas, to be honest.

You were right, it works perfectly smooth with the same movie (read over gigabit network) on the 2500K computer, so no HT.
So there is a problem with HT CPUs, even if HT if disabled.

Good luck to patch it

Thanks for the report!