[vlc-devel] need comment on libvlc log

[Rafaël Carré]

Le Sat, 26 Nov 2011 09:54:39 +0700,
Sergey Radionov <rsatom at gmail.com> a écrit :

> same file under nightly vlc-1.2.0-pre2-20111125-0008-win32-debug is playing
> good:
> 
> main debug: adding item `1.mpg' ( file:///F:/video/1.mpg )
> qt4 debug: Adding a new MRL to recent ones: file:///F:/video/1.mpg
> main debug: rebuilding array of current - root Плейлист
> main debug: rebuild done - 1 items, index -1
> main debug: processing request item: 1.mpg, node: null, skip: 0
> main debug: resyncing on 1.mpg
> main debug: 1.mpg is at 0
> main debug: starting playback of the new playlist item
> main debug: creating new input thread
> main debug: Creating an input for '1.mpg'
> main debug: Creating an input for '1.mpg'
> main debug: using timeshift granularity of 50 MiB, in path 'C:\Temp'
> main debug: `file:///F:/video/1.mpg' gives access `file' demux `' path
> `/F:/video/1.mpg'
> main debug: creating demux: access='file' demux=''
> location='/F:/video/1.mpg' file='F:\video\1.mpg'
> 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.592 ms - Total 0.592 ms / 1 intvls (Avg
> 0.592 ms)
> main debug: creating access 'file' location='/F:/video/1.mpg',
> path='F:\video\1.mpg'
> main debug: looking for access module: 3 candidates
> filesystem debug: opening file `F:\video\1.mpg'
> main debug: using access module "filesystem"
> main debug: TIMER module_need() : 0.326 ms - Total 0.326 ms / 1 intvls (Avg
> 0.326 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 - 8196 KiB/s
> main debug: looking for stream_filter module: 3 candidates
> main debug: no stream_filter module matching "any" could be loaded
> main debug: TIMER module_need() : 0.186 ms - Total 0.186 ms / 1 intvls (Avg
> 0.186 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.257 ms - Total 0.257 ms / 1 intvls (Avg
> 0.257 ms)
> main debug: creating demux: access='file' demux=''
> location='/F:/video/1.mpg' file='F:\video\1.mpg'
> main debug: looking for demux module: 55 candidates
> qt4 debug: IM: Setting an input
> ts warning: TS module discarded (lost sync)
> mod warning: MOD validation failed (ext=mpg)
> main debug: using demux module "ps"
> main debug: TIMER module_need() : 35.453 ms - Total 35.453 ms / 1 intvls
> (Avg 35.453 ms)
> main debug: looking for a subtitle file in F:\video
> main debug: looking for meta reader module: 2 candidates
> lua debug: Trying Lua scripts in C:\Documents and Settings\F\Application
> Data\vlc\lua\meta\reader
> lua debug: Trying Lua scripts in
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\reader
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\reader\filename.luac
> main debug: meta ok for (null), need to fetch art
> main debug: no meta reader module matching "any" could be loaded
> main debug: TIMER module_need() : 2.403 ms - Total 2.403 ms / 1 intvls (Avg
> 2.403 ms)
> main debug: `file:///F:/video/1.mpg' successfully opened
> ps debug: we found a length of: 229181633
> ps debug: we found a length of: 229329833
> main debug: selecting program id=0
> main debug: looking for decoder module: 31 candidates
> main debug: looking for meta fetcher module: 1 candidate
> lua debug: Trying Lua scripts in C:\Documents and Settings\F\Application
> Data\vlc\lua\meta\fetcher
> lua debug: Trying Lua scripts in
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\fetcher
> avcodec debug: libavcodec initialized (interface 0x351401)
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\fetcher\tvrage.luac
> main debug: using meta fetcher module "lua"
> avcodec debug: trying to use direct rendering
> avcodec debug: allowing 2 thread(s) for decoding
> main debug: TIMER module_need() : 2.064 ms - Total 2.064 ms / 1 intvls (Avg
> 2.064 ms)
> main debug: removing module "lua"
> main debug: searching art for 1.mpg
> main debug: looking for art finder module: 2 candidates
> lua debug: Trying Lua scripts in C:\Documents and Settings\F\Application
> Data\vlc\lua\meta\art
> lua debug: Trying Lua scripts in
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\art
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\art\01_googleimage.luac
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\art\02_frenchtv.luac
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\art\03_lastfm.luac
> lua debug: Trying Lua playlist script
> E:\vlc-bin\vlc-1.2.0-pre2-20111125-0008-win32-debug\lua\meta\art\04_musicbrainz.luac
> main debug: no art finder module matching "any" could be loaded
> main debug: TIMER module_need() : 6.801 ms - Total 6.801 ms / 1 intvls (Avg
> 6.801 ms)
> main debug: art not found for 1.mpg
> avcodec debug: ffmpeg codec (MPEG-1/2 Video) started
> avcodec debug: using slice thread mode with 2 threads
> main debug: using decoder module "avcodec"
> main debug: TIMER module_need() : 50.425 ms - Total 50.425 ms / 1 intvls
> (Avg 50.425 ms)
> main debug: looking for packetizer module: 21 candidates
> main debug: using packetizer module "packetizer_mpegvideo"
> main debug: TIMER module_need() : 6.310 ms - Total 6.310 ms / 1 intvls (Avg
> 6.310 ms)
> main debug: looking for decoder module: 31 candidates
> main debug: using decoder module "mpeg_audio"
> main debug: TIMER module_need() : 0.590 ms - Total 0.590 ms / 1 intvls (Avg
> 0.590 ms)
> main debug: Buffering 0%
> main debug: Buffering 4%
> main debug: Buffering 8%
> packetizer_mpegvideo debug: size 352x240 fps=29.970
> main debug: Buffering 13%
> main debug: Buffering 17%
> main debug: Buffering 22%
> 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() : 4.026 ms - Total 4.026 ms / 1 intvls (Avg
> 4.026 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() : 4.832 ms - Total 4.832 ms / 1 intvls (Avg
> 4.832 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() : 9.074 ms - Total 9.074 ms / 1 intvls (Avg
> 9.074 ms)
> main debug: Deinterlacing available
> main debug: deinterlace 0, mode blend, is_needed 0
> main debug: Buffering 26%
> main debug: Buffering 31%
> main debug: Buffering 35%
> main debug: Buffering 40%
> main debug: Buffering 44%
> main debug: Buffering 48%
> main debug: Buffering 53%
> main debug: Buffering 57%
> main debug: Buffering 62%
> main debug: Buffering 66%
> main debug: Buffering 71%
> main debug: Buffering 75%
> main debug: Buffering 80%
> main debug: Buffering 84%
> main debug: Buffering 88%
> main debug: Buffering 93%
> main debug: Buffering 97%
> main debug: Stream buffering done (306 ms in 26 ms)
> mpeg_audio debug: MPGA channels:2 samplerate:44100 bitrate:192
> 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() : 84.907 ms - Total 84.907 ms / 1 intvls
> (Avg 84.907 ms)
> direct3d debug: created video sub-window
> direct3d debug: Vout EventThread running
> direct3d debug: disabling screen saver
> main debug: VoutDisplayEvent 'resize' 360x296 window
> direct3d debug: DirectXUpdateRects image_src_clipped coords: 0,0,352,240
> 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() : 163.909 ms - Total 163.909 ms / 1 intvls
> (Avg 163.909 ms)
> main debug: original format sz 352x240, of (0,0), vsz 352x240, 4cc I420,
> sar 200:219, 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.479 ms - Total 0.479 ms / 1 intvls (Avg
> 0.479 ms)
> main debug: creating audio output
> avcodec debug: using direct rendering
> main debug: looking for audio output module: 2 candidates
> aout_directx debug: Opening DirectSound Audio Output
> main debug: VoutDisplayEvent 'resize' 454x262 window
> direct3d debug: DirectXUpdateRects image_src_clipped coords: 0,0,352,240
> main debug: End of video preroll
> main debug: Received first picture
> direct3d debug: Created 44x18 texture for OSD
> main debug: Post-processing available
> direct3d debug: Reusing 44x18 texture for OSD
> aout_directx debug: found device: Primary Sound Driver
> aout_directx debug: found device: Realtek HD Audio output
> aout_directx debug: found device: Аудио Bluetooth
> aout_directx debug: device supports 2 channels (DEFAULT!)
> direct3d debug: Reusing 44x18 texture for OSD
> 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.277 ms - Total 93.277 ms / 1 intvls
> (Avg 93.277 ms)
> main debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes
> main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes
> main debug: filter(s) 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo
> main debug: looking for audio filter module: 13 candidates
> audio_format debug: f32l->s16l, bits per sample: 32->16
> main debug: using audio filter module "audio_format"
> main debug: TIMER module_need() : 3.610 ms - Total 3.610 ms / 1 intvls (Avg
> 3.610 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.394 ms - Total 0.394 ms / 1 intvls (Avg
> 0.394 ms)
> main debug: input 'mpga' 44100 Hz Stereo frame=1152 samples/1262 bytes
> main debug: looking for audio filter module: 1 candidate
> scaletempo debug: format: 44100 rate, 2 nch, 4 bps, fl32
> scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
> scaletempo debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059
> standing, 264 overlap, 617 search, 2204 queue, fl32 mode
> main debug: using audio filter module "scaletempo"
> main debug: TIMER module_need() : 0.433 ms - Total 0.433 ms / 1 intvls (Avg
> 0.433 ms)
> main debug: filter(s) 'mpga'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
> main debug: looking for audio filter module: 13 candidates
> mpgatofixed32 debug: mpga->f32l, bits per sample: 32
> main debug: using audio filter module "mpgatofixed32"
> main debug: TIMER module_need() : 0.108 ms - Total 0.108 ms / 1 intvls (Avg
> 0.108 ms)
> main debug: conversion pipeline completed
> main debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
> main debug: conversion pipeline completed
> main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo
> main debug: looking for audio filter module: 13 candidates
> main debug: using audio filter module "speex_resampler"
> main debug: TIMER module_need() : 0.300 ms - Total 0.300 ms / 1 intvls (Avg
> 0.300 ms)
> main debug: conversion pipeline completed
> main debug: End of audio preroll
> main debug: Decoder buffering done in 266 ms
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> main debug: auto hiding mouse
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> direct3d debug: Reusing 44x18 texture for OSD
> main debug: incoming request - stopping current input
> main debug: control type=0
> main debug: control: stopping input
> main debug: dying input
> main debug: auto hiding mouse
> main debug: dying input
> direct3d debug: Reusing 44x18 texture for OSD
> main warning: can't get output picture
> avcodec warning: disabling direct rendering
> main warning: can't get output picture
> main debug: removing module "avcodec"
> avcodec debug: ffmpeg codec (MPEG-1/2 Video) stopped
> main debug: killing decoder fourcc `mpgv', 10 PES in FIFO
> main debug: saving a free vout
> main debug: reusing provided vout
> main debug: removing module "packetizer_mpegvideo"
> main debug: removing module "mpeg_audio"
> main debug: killing decoder fourcc `mpga', 0 PES in FIFO
> main debug: removing module "mpgatofixed32"
> main debug: removing module "scaletempo"
> main debug: removing module "speex_resampler"
> main debug: removing module "aout_directx"
> aout_directx debug: closing audio device
> aout_directx debug: DirectSoundThread exiting
> main debug: removing module "audio_format"
> main debug: removing module "float32_mixer"
> main debug: releasing audio output
> main debug: removing module "ps"
> main debug: Program doesn't contain anymore ES
> main debug: removing module "stream_filter_record"
> main debug: removing module "filesystem"
> main debug: dead input
> main debug: destroying useless vout
> main debug: removing module "direct3d"
> direct3d debug: Direct3D scene released successfully
> qt4 debug: IM: Deleting the input
> main debug: Destroying the input for '1.mpg'
> main debug: TIMER input launching for '1.mpg' : 43.695 ms - Total 43.695 ms
> / 1 intvls (Avg 43.695 ms)
> direct3d debug: DirectXEventThread terminating
> direct3d debug: DirectXCloseWindow
> direct3d debug: WinProc WM_DESTROY
> qt4 debug: releasing video...
> qt4 debug: Video is not needed anymore
> main debug: removing module "freetype"
> main debug: removing module "yuvp"
> main debug: removing module "swscale"
> 
> What it is? incompatible contribs? or it may be something else?

Probably that the web plugins have been untested and unmaintained for years.

-- 
Rafaël Carré