VLC media player 0.9.4 Grishenko [00000001] main libvlc debug: VLC media player - version 0.9.4 Grishenko - (c) 1996-2008 the VideoLAN team [00000001] main libvlc debug: libvlc was configured with ./configure '--build=i486-linux-gnu' '--enable-maintaner-mode' '--enable-release' '--prefix=/usr' '--enable-libtool' '--enable-fast-install' '--with-binary-version=1ubuntu3' '--disable-update-check' '--disable-gnome' '--disable-gtk' '--disable-familiar' '--disable-fb' '--enable-ggi' '--enable-sdl' '--enable-esd' '--enable-mad' '--enable-arts' '--enable-jack' '--enable-pulse' '--enable-lirc' '--enable-a52' '--enable-aa' '--enable-dvbpsi' '--enable-mozilla' '--with-mozilla-pkg=libxul-plugin' '--disable-kde' '--enable-mp4' '--enable-dvb' '--disable-satellite' '--enable-ogg' '--enable-vorbis' '--enable-shout' '--enable-qt4' '--disable-slp' '--enable-flac' '--disable-skins' '--disable-basic-skins' '--enable-skins2' '--enable-freetype' '--enable-mkv' '--enable-speex' '--enable-caca' '--enable-live555' '--enable-libmpeg2' '--enable-fribidi' '--enable-cdio' '--enable-mod' '--enable-theora' '--enable-modplug' '--enable-dvdnav' '--enable-gnutls' '--enable-ffmpeg' '--enable-ncurses' '--enable-smb' '--disable-gnomevfs' '--enable-bonjour' '--enable-mpc' '--enable-vcd' '--enable-vcdx' '--enable-notify' '--enable-twolame' '--enable-x264' '--enable-faad' '--disable-zvbi' '--enable-telx' '--enable-mediacontrol-bindings' '--disable-atmo' '--enable-taglib' '--enable-libass' '--enable-libdca' '--enable-alsa' '--enable-dv' '--enable-v4l' '--enable-v4l2' '--enable-pvr' '--enable-svgalib' '--enable-dvd' '--without-dvdcss' 'build_alias=i486-linux-gnu' 'CFLAGS=-g -O2' 'LDFLAGS=-Wl,--as-needed' 'CPPFLAGS=' 'CXXFLAGS=-g -O2' [00000001] main libvlc debug: translation test: code is "nl" [00000001] main libvlc debug: checking builtin modules [00000001] main libvlc debug: checking plugin modules [00000001] main libvlc debug: loading plugins cache file /home/*****/.cache/vlc/plugins-04041e.dat [00000001] main libvlc debug: recursively browsing `/usr/lib/vlc' [00000001] main libvlc debug: module bank initialized, found 271 modules [00000001] main libvlc debug: opening config file (/home/*****/.config/vlc/vlcrc) [00000001] main libvlc debug: CPU has capabilities 486 586 MMX MMXEXT SSE SSE2 FPU [00000001] main libvlc debug: looking for memcpy module: 3 candidates [00000001] main libvlc debug: using memcpy module "memcpymmxext" [00000369] main interaction debug: thread started [00000369] main interaction debug: thread 3080461200 (Interaction control) created at priority 0 (interface/interaction.c:382) [00000371] main input debug: Creating an input for 'Mediatheek' [00000371] main input debug: Input is a meta file: disabling unneeded options [00000371] main input debug: `file/xspf-open:///home/*****/.local/share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/*****/.local/share/vlc/ml.xspf' [00000371] main input debug: creating access 'file' path='/home/*****/.local/share/vlc/ml.xspf' [00000372] main access debug: looking for access module: 3 candidates [00000372] access_mmap access debug: opening file /home/*****/.local/share/vlc/ml.xspf [00000372] main access debug: using access module "access_mmap" [00000372] main access debug: TIMER module_Need() : 2,009 ms - Total 2,009 ms / 1 intvls (Avg 2,009 ms) [00000376] main stream debug: Using AStream*Block [00000376] main stream debug: pre buffering [00000376] main stream debug: received first data for our buffer [00000372] access_mmap access debug: at end of memory mapped file [00000371] main input debug: creating demux: access='file' demux='xspf-open' path='/home/*****/.local/share/vlc/ml.xspf' [00000377] main demux debug: looking for demux module: 1 candidate [00000377] playlist demux debug: using XSPF playlist reader [00000377] main demux debug: using demux module "playlist" [00000377] main demux debug: TIMER module_Need() : 1,657 ms - Total 1,657 ms / 1 intvls (Avg 1,657 ms) [00000371] main input debug: `file/xspf-open:///home/*****/.local/share/vlc/ml.xspf' successfully opened [00000392] main xml debug: looking for xml module: 2 candidates [00000392] main xml debug: using xml module "xml" [00000392] main xml debug: TIMER module_Need() : 1,909 ms - Total 1,909 ms / 1 intvls (Avg 1,909 ms) [00000372] access_mmap access debug: at end of memory mapped file [00000377] playlist demux warning: invalid attribute:"xmlns:vlc" [00000377] playlist demux debug: parsed 0 tracks successfully [00000392] main xml debug: removing module "xml" [00000371] main input debug: EOF reached [00000371] main input debug: control type=1 [00000377] main demux debug: removing module "playlist" [00000372] main access debug: removing module "access_mmap" [00000371] main input debug: TIMER input launching for 'Mediatheek' : 15,255 ms - Total 15,255 ms / 1 intvls (Avg 15,255 ms) [00000394] main preparser debug: thread started [00000394] main preparser debug: waiting for thread initialization [00000394] main preparser debug: thread 3070512016 (preparser) created at priority 0 (playlist/thread.c:79) [00000395] main fetcher debug: thread started [00000395] main fetcher debug: waiting for thread initialization [00000395] main fetcher debug: thread 3062119312 (fetcher) created at priority 0 (playlist/thread.c:108) [00000370] main playlist debug: thread started [00000370] main playlist debug: waiting for thread initialization [00000370] main playlist debug: rebuilding array of current - root Afspeellijst [00000370] main playlist debug: rebuild done - 0 items, index -1 [00000370] main playlist debug: thread 3053726608 (playlist) created at priority 0 (playlist/thread.c:117) [00000396] main interface debug: looking for interface module: 1 candidate [00000396] main interface debug: using interface module "hotkeys" [00000396] main interface debug: TIMER module_Need() : 1,127 ms - Total 1,127 ms / 1 intvls (Avg 1,127 ms) [00000396] main interface debug: thread started [00000396] main interface debug: thread 3045333904 (interface) created at priority 0 (interface/interface.c:168) [00000398] main interface debug: looking for interface module: 1 candidate [00000398] main interface debug: using interface module "inhibit" [00000398] main interface debug: TIMER module_Need() : 6,878 ms - Total 6,878 ms / 1 intvls (Avg 6,878 ms) [00000398] main interface debug: thread started [00000398] main interface debug: thread 3036941200 (interface) created at priority 0 (interface/interface.c:168) [00000400] main interface debug: looking for interface module: 1 candidate [00000400] main interface debug: using interface module "screensaver" [00000400] main interface debug: TIMER module_Need() : 0,836 ms - Total 0,836 ms / 1 intvls (Avg 0,836 ms) [00000400] main interface debug: thread started [00000400] main interface debug: thread 3028548496 (interface) created at priority 0 (interface/interface.c:168) [00000402] main interface debug: looking for interface module: 22 candidates [00000402] main interface debug: using interface module "signals" [00000402] main interface debug: TIMER module_Need() : 0,842 ms - Total 0,842 ms / 1 intvls (Avg 0,842 ms) [00000402] main interface debug: thread started [00000402] main interface debug: thread 3011763088 (interface) created at priority 0 (interface/interface.c:168) [00000001] main libvlc: Start vlc met standaard interface. Gebruik 'cvlc' om vlc zonder interface te gebruiken. [00000404] main interface debug: looking for interface module: 4 candidates [00000404] main interface debug: using interface module "qt4" [00000404] main interface debug: TIMER module_Need() : 129,598 ms - Total 129,598 ms / 1 intvls (Avg 129,598 ms) [00000404] main interface debug: thread 2985020304 (interface) created at priority 0 (interface/interface.c:168) [00000404] main interface debug: thread started [00000404] qt4 interface debug: Error while initializing qt-specific localization [00000404] qt4 interface debug: New item: *****.avi [00000370] main playlist debug: adding item `*****.avi' ( *****.avi ) [00000370] main playlist debug: rebuilding array of current - root Afspeellijst [00000370] main playlist debug: rebuild done - 1 items, index -1 [00000370] main playlist debug: starting new item [00000370] main playlist debug: processing request item *****.avi node null skip 0 [00000370] main playlist debug: resyncing on *****.avi [00000370] main playlist debug: *****.avi is at 0 [00000370] main playlist debug: creating new input thread [00000408] main input debug: Creating an input for '*****.avi' [00000408] main input debug: thread started [00000408] main input debug: waiting for thread initialization [00000408] main input debug: `*****.avi' gives access `' demux `' path `*****.avi' [00000408] main input debug: creating demux: access='' demux='' path='*****.avi' [00000409] main demux debug: looking for access_demux module: 3 candidates [00000409] main demux debug: TIMER module_Need() : 5.694 ms - Total 5.694 ms / 1 intvls (Avg 5.694 ms) [00000408] main input debug: creating access '' path='*****.avi' [00000414] main access debug: looking for access module: 6 candidates [00000414] vcd access debug: trying .cue file: *****.cue [00000414] vcd access debug: could not find .cue file [00000408] main input debug: thread 2954881936 (input) created at priority 10 (input/input.c:370) [00000404] qt4 interface debug: Updating the stream status: 3 [00000414] access_mmap access debug: opening file *****.avi [00000414] main access debug: using access module "access_mmap" [00000414] main access debug: TIMER module_Need() : 9.265 ms - Total 9.265 ms / 1 intvls (Avg 9.265 ms) [00000417] main stream debug: Using AStream*Block [00000417] main stream debug: pre buffering [00000417] main stream debug: received first data for our buffer [00000417] main stream debug: prebuffering done 1048576 bytes in 0s - 2364896 kbytes/s [00000408] main input debug: creating demux: access='' demux='' path='*****.avi' [00000418] main demux debug: looking for demux module: 60 candidates [00000417] avi stream debug: found Chunk fourcc:46464952 (RIFF) size:734427310 pos:0 [00000417] avi stream debug: found LIST chunk: 'AVI ' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:8818 pos:12 [00000417] avi stream debug: found LIST chunk: 'hdrl' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:68697661 (avih) size:56 pos:24 [00000417] avi stream debug: avih: streams:2 flags: HAS_INDEX IS_INTERLEAVED 608x336 [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:4244 pos:88 [00000417] avi stream debug: found LIST chunk: 'strl' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:68727473 (strh) size:56 pos:100 [00000417] avi stream debug: strh: type:vids handler:0x64697678 samplesize:0 23.98fps [00000417] avi stream debug: found Chunk fourcc:66727473 (strf) size:40 pos:164 [00000417] avi stream debug: strf: video:XVID 608x336 planes:1 12bpp [00000417] avi stream debug: found Chunk fourcc:4b4e554a (JUNK) size:4120 pos:212 [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:4222 pos:4340 [00000417] avi stream debug: found LIST chunk: 'strl' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:68727473 (strh) size:56 pos:4352 [00000417] avi stream debug: strh: type:auds handler:0x00000000 samplesize:1 48000.00fps [00000417] avi stream debug: found Chunk fourcc:66727473 (strf) size:18 pos:4416 [00000417] avi stream debug: strf: audio:0x2000 channels:6 48000Hz 0bits/sample 375kb/s [00000417] avi stream debug: found Chunk fourcc:4b4e554a (JUNK) size:4120 pos:4442 [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:260 pos:8570 [00000417] avi stream debug: found LIST chunk: 'odml' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:686c6d64 (dmlh) size:248 pos:8582 [00000417] avi stream warning: unknown chunk (not loaded) [00000417] avi stream debug: [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:28 pos:8838 [00000417] avi stream debug: found LIST chunk: 'INFO' [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:54465349 (ISFT) size:15 pos:8850 [00000417] avi stream debug: ISFT: software : Nandub v1.0rc2 [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:4b4e554a (JUNK) size:1358 pos:8874 [00000417] avi stream debug: found Chunk fourcc:5453494c (LIST) size:731526950 pos:10240 [00000417] avi stream debug: skipping movi chunk [00000417] main stream debug: b_seek=1 th*avg=1048576 skip=730488622 [00000417] avi stream debug: found Chunk fourcc:31786469 (idx1) size:2890112 pos:731537198 [00000417] avi stream debug: idx1: index entry:180632 [00000417] avi stream debug: [00000417] avi stream debug: found Chunk fourcc:4b4e554a (JUNK) size:1858 pos:734427318 [00000417] main stream debug: b_seek=0 th*avg=985140 skip=0 [00000414] access_mmap access debug: at end of memory mapped file [00000417] avi stream debug: * LIST-root size:734429184 pos:0 [00000417] avi stream debug: + RIFF-AVI size:734427310 pos:0 [00000417] avi stream debug: | + LIST-hdrl size:8818 pos:12 [00000417] avi stream debug: | | + avih size:56 pos:24 [00000417] avi stream debug: | | + LIST-strl size:4244 pos:88 [00000417] avi stream debug: | | | + strh size:56 pos:100 [00000417] avi stream debug: | | | + strf size:40 pos:164 [00000417] avi stream debug: | | | + JUNK size:4120 pos:212 [00000417] avi stream debug: | | + LIST-strl size:4222 pos:4340 [00000417] avi stream debug: | | | + strh size:56 pos:4352 [00000417] avi stream debug: | | | + strf size:18 pos:4416 [00000417] avi stream debug: | | | + JUNK size:4120 pos:4442 [00000417] avi stream debug: | | + LIST-odml size:260 pos:8570 [00000417] avi stream debug: | | | + dmlh size:248 pos:8582 [00000417] avi stream debug: | + LIST-INFO size:28 pos:8838 [00000417] avi stream debug: | | + ISFT size:15 pos:8850 [00000417] avi stream debug: | + JUNK size:1358 pos:8874 [00000417] avi stream debug: | + LIST-movi size:731526950 pos:10240 [00000417] avi stream debug: | + idx1 size:2890112 pos:731537198 [00000417] avi stream debug: + JUNK size:1858 pos:734427318 [00000418] avi demux debug: AVIH: 2 stream, flags HAS_INDEX IS_INTERLEAVED [00000418] avi demux debug: stream[0] rate:2997 scale:125 samplesize:0 [00000418] avi demux debug: stream[0] video(XVID) 608x336 12bpp 23.976000fps [00000408] main input debug: selecting program id=0 [00000418] avi demux debug: stream[1] rate:48000 scale:1 samplesize:1 [00000418] avi demux debug: stream[1] audio(0x2000) 6 channels 48000Hz 0bits [00000418] avi demux debug: stream[0] created 90321 index entries [00000418] avi demux debug: stream[1] created 90311 index entries [00000418] avi demux debug: stream[0] length:3767 (based on index) [00000418] avi demux debug: stream[1] length:3767 (based on index) [00000418] main demux debug: using demux module "avi" [00000418] main demux debug: TIMER module_Need() : 75.931 ms - Total 75.931 ms / 1 intvls (Avg 75.931 ms) [00000408] main input debug: looking for a subtitle file in /*****/ [00000420] main decoder debug: looking for decoder module: 30 candidates [00000404] qt4 interface debug: New Event: type 1103 [00000404] qt4 interface debug: Updating the stream status: 2 [00000404] qt4 interface debug: New Event: type 1108 [00000420] avcodec decoder debug: libavcodec initialized (interface 3355136 ) [00000420] avcodec decoder debug: using direct rendering [00000420] avcodec decoder debug: ffmpeg codec (MPEG-4 Video) started [00000420] main decoder debug: using decoder module "avcodec" [00000420] main decoder debug: TIMER module_Need() : 35.900 ms - Total 35.900 ms / 1 intvls (Avg 35.900 ms) [00000420] main decoder debug: thread started [00000420] main decoder debug: thread 2927655824 (decoder) created at priority 0 (input/decoder.c:217) [00000453] main decoder debug: looking for decoder module: 30 candidates [00000453] main decoder debug: using decoder module "a52" [00000453] main decoder debug: TIMER module_Need() : 0.528 ms - Total 0.528 ms / 1 intvls (Avg 0.528 ms) [00000453] main decoder debug: thread started [00000453] main decoder debug: thread 2919263120 (decoder) created at priority 5 (input/decoder.c:217) [00000408] main input debug: `*****.avi' successfully opened [00000418] avi demux debug: old:0 < new 0 [00000408] main input debug: control type=1 [00000404] qt4 interface debug: New Event: type 1103 [00000404] qt4 interface debug: Updating the stream status: 3 [00000420] main decoder debug: no usable vout present, spawning one [00000454] main video output debug: window size: 608x336 [00000454] main video output debug: looking for video output module: 6 candidates [00000454] xvideo video output warning: no free XVideo port found for format 0x30323449 (I420) [00000454] xvideo video output warning: no free XVideo port found for format 0x32595559 (YUY2) [00000454] xvideo video output warning: no free XVideo port found for format 0x36315652 (RV16) [00000458] main window debug: looking for vout window module: 2 candidates [00000458] qt4 window debug: waiting for interface... [00000458] qt4 window debug: requesting window... [00000404] qt4 interface debug: Video was requested -1, -1 [00000404] qt4 interface debug: Video is resizing to: 608 336 [00000404] qt4 interface debug: Updating the geometry [00000454] qt4 video output debug: Qt FS: Attaching Vout [00000454] qt4 video output debug: Qt: Changing Fullscreen Mode [00000458] main window debug: using vout window module "qt4" [00000458] main window debug: TIMER module_Need() : 6.320 ms - Total 6.320 ms / 1 intvls (Avg 6.320 ms) QPainter::begin: Paint device returned engine == 0, type: 1 QPainter::begin: Paint device returned engine == 0, type: 1 QPainter::begin: Paint device returned engine == 0, type: 1 [00000454] x11 video output debug: XShm video extension v1.1 (without pixmaps, opcode: 145) [00000454] x11 video output debug: Window manager supports NetWM [00000454] x11 video output debug: Window manager supports _NET_WM_STATE_FULLSCREEN [00000454] x11 video output debug: Window manager supports _NET_WM_STATE_ABOVE [00000454] x11 video output debug: Window manager supports _NET_WM_STATE_BELOW [00000454] main video output debug: using video output module "x11" [00000454] main video output debug: TIMER module_Need() : 334.169 ms - Total 334.169 ms / 1 intvls (Avg 334.169 ms) [00000454] main video output debug: waiting for thread initialization [00000454] main video output debug: thread started [00000454] x11 video output debug: x11 image size 608x336 (0,0,608x336) [00000454] main video output debug: got 2 direct buffer(s) [00000454] main video output debug: picture in 608x336 (0,0,608x336), chroma I420, ar 390857:216000, sar 1:1 [00000454] main video output debug: picture user 608x336 (0,0,608x336), chroma I420, ar 390857:216000, sar 1:1 [00000454] main video output debug: picture out 608x336 (0,0,608x336), chroma RV32, ar 390857:216000, sar 1:1 [00000462] main chroma debug: looking for video filter2 module: 19 candidates [00000462] swscale chroma debug: 608x336 chroma: I420 -> 608x336 chroma: RV32 with scaling using Bicubic (good quality) [00000462] main chroma debug: using video filter2 module "swscale" [00000462] main chroma debug: TIMER module_Need() : 2.067 ms - Total 2.067 ms / 1 intvls (Avg 2.067 ms) [00000454] main video output debug: indirect render, mapping render pictures 0-7 to system pictures 2-9 [00000454] main video output debug: thread 2909666192 (video output) created at priority 15 (video_output/video_output.c:504) [00000404] qt4 interface debug: New Event: type 1109 [00000462] main chroma debug: removing module "swscale" [00000454] x11 video output debug: x11 image size 608x336 (0,0,608x336) [00000466] main chroma debug: looking for video filter2 module: 19 candidates [00000466] swscale chroma debug: 608x336 chroma: I420 -> 608x336 chroma: RV32 with scaling using Bicubic (good quality) [00000466] main chroma debug: using video filter2 module "swscale" [00000466] main chroma debug: TIMER module_Need() : 0.793 ms - Total 0.793 ms / 1 intvls (Avg 0.793 ms) [00000454] main video output warning: late picture skipped (393148) [00000454] main video output warning: late picture skipped (351504) [00000454] main video output warning: late picture skipped (309819) [00000454] main video output warning: late picture skipped (226439) [00000453] message decoder warning: message queue overflowed [00000453] a52 decoder: A/52 channels:6 samplerate:48000 bitrate:384000 [00000453] main decoder debug: no aout present, spawning one [00000467] main audio output debug: looking for audio output module: 3 candidates ALSA lib setup.c:555:(add_elem) Cannot obtain info for CTL elem (MIXER,'IEC958 Playback Default',0,0,0): Bestand of map bestaat niet [00000467] alsa audio output debug: opening ALSA device `default' [00000467] main audio output debug: thread 2884213648 (aout) created at priority 15 (alsa.c:687) [00000467] main audio output debug: using audio output module "alsa" [00000467] main audio output debug: TIMER module_Need() : 29.433 ms - Total 29.433 ms / 1 intvls (Avg 29.433 ms) [00000467] main audio output debug: thread started [00000467] main audio output debug: output 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes [00000467] main audio output debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes [00000467] main audio output debug: no need for any filter [00000467] main audio output debug: looking for audio mixer module: 3 candidates [00000467] main audio output debug: using audio mixer module "float32_mixer" [00000467] main audio output debug: TIMER module_Need() : 0.644 ms - Total 0.644 ms / 1 intvls (Avg 0.644 ms) [00000467] main audio output debug: input 'a52 ' 48000 Hz 3F2R/LFE frame=1536 samples/1536 bytes [00000467] main audio output debug: filter(s) 'a52 '->'fl32' 48000 Hz->48000 Hz 3F2R/LFE->Stereo [00000469] main audio output debug: looking for audio filter module: 24 candidates [00000469] main audio output debug: using audio filter module "a52tofloat32" [00000469] main audio output debug: TIMER module_Need() : 1.734 ms - Total 1.734 ms / 1 intvls (Avg 1.734 ms) [00000467] main audio output debug: found a filter for the whole conversion [00000467] main audio output debug: filter(s) 'fl32'->'fl32' 52800 Hz->48000 Hz Stereo->Stereo [00000472] main audio output debug: looking for audio filter module: 24 candidates [00000472] main audio output debug: using audio filter module "linear_resampler" [00000472] main audio output debug: TIMER module_Need() : 5.565 ms - Total 5.565 ms / 1 intvls (Avg 5.565 ms) [00000467] main audio output debug: found a filter for the whole conversion [00000467] main audio output warning: output date isn't PTS date, requesting resampling (70346) [00000467] main audio output warning: buffer is 64284 late, triggering upsampling Segmentatiefout