VLC media player 0.9.8a Grishenko
[00000001] main libvlc debug: VLC media player - version 0.9.8a Grishenko - (c) 1996-2008 the VideoLAN team
[00000001] main libvlc debug: libvlc was configured with ./configure  '--build=i486-linux-gnu' '--enable-maintainer-mode' '--enable-release' '--prefix=/usr' '--enable-libtool' '--enable-fast-install' '--with-binary-version=3' '--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=iceape-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-faad' '--disable-zvbi' '--enable-telx' '--enable-mediacontrol-bindings' '--disable-x264' '--disable-atmo' '--enable-taglib' '--enable-libass' '--enable-libdca' '--enable-realrtsp' '--disable-dv' '--enable-alsa' '--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 "de"
[00000001] main libvlc debug: checking builtin modules
[00000001] main libvlc debug: checking plugin modules
[00000001] main libvlc debug: loading plugins cache file /home/krasnoj/.cache/vlc/plugins-04041e.dat
[00000001] main libvlc debug: recursively browsing `/usr/lib/vlc'
[00000001] main libvlc debug: module bank initialized, found 270 modules
[00000001] main libvlc debug: opening config file (/home/krasnoj/.config/vlc/vlcrc)
[00000001] main libvlc debug: CPU has capabilities 486 586 MMX 3DNow! MMXEXT SSE SSE2 FPU 
[00000001] main libvlc debug: looking for memcpy module: 4 candidates
[00000001] main libvlc debug: using memcpy module "memcpymmxext"
[00000367] main interaction debug: thread started
[00000367] main interaction debug: thread 3078658960 (Interaction control) created at priority 0 (interface/interaction.c:382)
[00000369] main input debug: Creating an input for 'Medienbibliothek'
[00000369] main input debug: Input is a meta file: disabling unneeded options
[00000369] main input debug: `file/xspf-open:///home/krasnoj/.local/share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/krasnoj/.local/share/vlc/ml.xspf'
[00000369] main input debug: creating access 'file' path='/home/krasnoj/.local/share/vlc/ml.xspf'
[00000370] main access debug: looking for access module: 3 candidates
[00000370] access_file access debug: opening file `/home/krasnoj/.local/share/vlc/ml.xspf'
[00000370] main access debug: using access module "access_file"
[00000370] main access debug: TIMER module_Need() : 2,505 ms - Total 2,505 ms / 1 intvls (Avg 2,505 ms)
[00000375] main stream debug: Using AStream*Stream
[00000375] main stream debug: pre-buffering...
[00000375] main stream debug: received first data for our buffer
[00000369] main input debug: creating demux: access='file' demux='xspf-open' path='/home/krasnoj/.local/share/vlc/ml.xspf'
[00000376] main demux debug: looking for demux module: 1 candidate
[00000376] playlist demux debug: using XSPF playlist reader
[00000376] main demux debug: using demux module "playlist"
[00000376] main demux debug: TIMER module_Need() : 1,195 ms - Total 1,195 ms / 1 intvls (Avg 1,195 ms)
[00000369] main input debug: `file/xspf-open:///home/krasnoj/.local/share/vlc/ml.xspf' successfully opened
[00000391] main xml debug: looking for xml module: 2 candidates
[00000391] main xml debug: using xml module "xml"
[00000391] main xml debug: TIMER module_Need() : 1,638 ms - Total 1,638 ms / 1 intvls (Avg 1,638 ms)
[00000376] playlist demux debug: parsed 0 tracks successfully
[00000391] main xml debug: removing module "xml"
[00000369] main input debug: EOF reached
[00000369] main input debug: control type=1
[00000376] main demux debug: removing module "playlist"
[00000370] main access debug: removing module "access_file"
[00000369] main input debug: TIMER input launching for 'Medienbibliothek' : 8,661 ms - Total 8,661 ms / 1 intvls (Avg 8,661 ms)
[00000393] main preparser debug: thread started
[00000393] main preparser debug: waiting for thread initialization
[00000393] main preparser debug: thread 3070266256 (preparser) created at priority 0 (playlist/thread.c:79)
[00000394] main fetcher debug: thread started
[00000394] main fetcher debug: waiting for thread initialization
[00000394] main fetcher debug: thread 3056216976 (fetcher) created at priority 0 (playlist/thread.c:108)
[00000368] main playlist debug: thread started
[00000368] main playlist debug: waiting for thread initialization
[00000368] main playlist debug: rebuilding array of current - root Wiedergabeliste
[00000368] main playlist debug: rebuild done - 0 items, index -1
[00000368] main playlist debug: thread 3047824272 (playlist) created at priority 0 (playlist/thread.c:117)
[00000395] main interface debug: looking for interface module: 1 candidate
[00000395] main interface debug: using interface module "hotkeys"
[00000395] main interface debug: TIMER module_Need() : 0,689 ms - Total 0,689 ms / 1 intvls (Avg 0,689 ms)
[00000395] main interface debug: thread started
[00000395] main interface debug: thread 3039431568 (interface) created at priority 0 (interface/interface.c:168)
[00000397] main interface debug: looking for interface module: 1 candidate
[00000397] main interface debug: using interface module "inhibit"
[00000397] main interface debug: TIMER module_Need() : 3,172 ms - Total 3,172 ms / 1 intvls (Avg 3,172 ms)
[00000397] main interface debug: thread 3031038864 (interface) created at priority 0 (interface/interface.c:168)
[00000397] main interface debug: thread started
[00000399] main interface debug: looking for interface module: 1 candidate
[00000399] main interface debug: using interface module "screensaver"
[00000399] main interface debug: TIMER module_Need() : 0,900 ms - Total 0,900 ms / 1 intvls (Avg 0,900 ms)
[00000399] main interface debug: thread started
[00000399] main interface debug: thread 3022646160 (interface) created at priority 0 (interface/interface.c:168)
[00000368] main playlist debug: adding item `wir_sind_helden-streichelzoo.flv' ( wir_sind_helden-streichelzoo.flv )
[00000401] main interface debug: looking for interface module: 22 candidates
[00000401] main interface debug: using interface module "signals"
[00000401] main interface debug: TIMER module_Need() : 0,473 ms - Total 0,473 ms / 1 intvls (Avg 0,473 ms)
[00000401] main interface debug: thread started
[00000401] main interface debug: thread 3005860752 (interface) created at priority 0 (interface/interface.c:168)
[00000403] main interface debug: looking for interface module: 22 candidates
[00000403] main interface debug: using interface module "qt4"
[00000403] main interface debug: TIMER module_Need() : 42,535 ms - Total 42,535 ms / 1 intvls (Avg 42,535 ms)
[00000403] main interface debug: thread started
[00000403] main interface debug: thread 2982955920 (interface) created at priority 0 (interface/interface.c:168)
[00000368] main playlist debug: rebuilding array of current - root Wiedergabeliste
[00000368] main playlist debug: rebuild done - 1 items, index -1
[00000368] main playlist debug: starting new item
[00000368] main playlist debug: processing request item null node Wiedergabeliste skip 0
[00000368] main playlist debug: creating new input thread
[00000406] main input debug: Creating an input for 'wir_sind_helden-streichelzoo.flv'
[00000406] main input debug: waiting for thread initialization
[00000406] main input debug: thread started
[00000406] main input debug: `wir_sind_helden-streichelzoo.flv' gives access `' demux `' path `wir_sind_helden-streichelzoo.flv'
[00000406] main input debug: creating demux: access='' demux='' path='wir_sind_helden-streichelzoo.flv'
[00000406] main input debug: thread 2972711824 (input) created at priority 10 (input/input.c:370)
[00000407] main demux debug: looking for access_demux module: 3 candidates
[00000407] main demux debug: TIMER module_Need() : 5,332 ms - Total 5,332 ms / 1 intvls (Avg 5,332 ms)
[00000406] main input debug: creating access '' path='wir_sind_helden-streichelzoo.flv'
[00000412] main access debug: looking for access module: 7 candidates
[00000412] vcd access debug: trying .cue file: wir_sind_helden-streichelzoo.cue
[00000412] vcd access debug: could not find .cue file
[00000412] access_file access debug: opening file `wir_sind_helden-streichelzoo.flv'
[00000412] main access debug: using access module "access_file"
[00000412] main access debug: TIMER module_Need() : 5,851 ms - Total 5,851 ms / 1 intvls (Avg 5,851 ms)
[00000415] main stream debug: Using AStream*Stream
[00000415] main stream debug: pre-buffering...
[00000415] main stream debug: received first data for our buffer
[00000415] main stream debug: pre-buffering done 1408981 bytes in 0s - 205091 kbytes/s
[00000406] main input debug: creating demux: access='' demux='' path='wir_sind_helden-streichelzoo.flv'
[00000416] main demux debug: looking for demux module: 52 candidates
[00000416] avformat demux debug: detected format: flv
[00000406] main input debug: selecting program id=0
[00000416] avformat demux debug: adding es: video codec = FLV1
[00000416] avformat demux debug: adding es: audio codec = mp3 
[00000416] avformat demux debug: AVFormat supported stream
[00000416] avformat demux debug:     - format = flv (FLV format)
[00000416] avformat demux debug:     - start time = 0
[00000416] avformat demux debug:     - duration = 220454000
[00000416] main demux debug: using demux module "avformat"
[00000416] main demux debug: TIMER module_Need() : 97,438 ms - Total 97,438 ms / 1 intvls (Avg 97,438 ms)
[00000406] main input debug: looking for a subtitle file in /home/krasnoj/Desktop/
[00000459] main decoder debug: looking for decoder module: 30 candidates
[00000459] avcodec decoder debug: libavcodec initialized (interface 3412992 )
[00000459] avcodec decoder debug: using direct rendering
[00000459] avcodec decoder debug: ffmpeg codec (Flash Video) started
[00000459] main decoder debug: using decoder module "avcodec"
[00000459] main decoder debug: TIMER module_Need() : 15,362 ms - Total 15,362 ms / 1 intvls (Avg 15,362 ms)
[00000459] main decoder debug: thread started
[00000459] main decoder debug: thread 2925525904 (decoder) created at priority 0 (input/decoder.c:217)
[00000492] main decoder debug: looking for decoder module: 30 candidates
[00000492] avcodec decoder debug: libavcodec already initialized
[00000492] avcodec decoder warning: Physical channel configuration not set : guessing
[00000492] avcodec decoder debug: ffmpeg codec (MPEG Audio layer 1/2/3) started
[00000492] main decoder debug: using decoder module "avcodec"
[00000492] main decoder debug: TIMER module_Need() : 40,103 ms - Total 40,103 ms / 1 intvls (Avg 40,103 ms)
[00000492] main decoder debug: thread started
[00000492] main decoder debug: thread 2916940688 (decoder) created at priority 5 (input/decoder.c:217)
[00000406] main input debug: `wir_sind_helden-streichelzoo.flv' successfully opened
[00000406] main input debug: control type=1
[00000459] main decoder debug: no usable vout present, spawning one
[00000492] main decoder debug: no aout present, spawning one
[00000493] main video output debug: window size: 320x240
[00000493] main video output debug: looking for video output module: 6 candidates
[00000495] main audio output debug: looking for audio output module: 3 candidates
[00000493] xvideo video output warning: no free XVideo port found for format 0x30323449 (I420)
[00000493] xvideo video output warning: no free XVideo port found for format 0x32595559 (YUY2)
[00000493] xvideo video output warning: no free XVideo port found for format 0x36315652 (RV16)
[00000498] main window debug: looking for vout window module: 1 candidate
[00000498] main window debug: TIMER module_Need() : 0,319 ms - Total 0,319 ms / 1 intvls (Avg 0,319 ms)
[00000498] main window debug: no window provider available
[00000495] alsa audio output debug: opening ALSA device `default'
[00000403] qt4 interface debug: Updating the stream status: 3
[00000495] main audio output debug: thread started
[00000495] main audio output debug: thread 2907974544 (aout) created at priority 15 (alsa.c:687)
[00000495] main audio output debug: using audio output module "alsa"
[00000495] main audio output debug: TIMER module_Need() : 117,542 ms - Total 117,542 ms / 1 intvls (Avg 117,542 ms)
[00000495] main audio output debug: output 'fl32' 22050 Hz Mono frame=1 samples/4 bytes
[00000495] main audio output debug: mixer 'fl32' 22050 Hz Mono frame=1 samples/4 bytes
[00000495] main audio output debug: no need for any filter
[00000495] main audio output debug: looking for audio mixer module: 3 candidates
[00000495] main audio output debug: using audio mixer module "float32_mixer"
[00000495] main audio output debug: TIMER module_Need() : 0,953 ms - Total 0,953 ms / 1 intvls (Avg 0,953 ms)
[00000495] main audio output debug: input 's16l' 22050 Hz Mono frame=1 samples/2 bytes
[00000495] main audio output debug: filter(s) 's16l'->'fl32' 22050 Hz->22050 Hz Mono->Mono
[00000500] main audio output debug: looking for audio filter module: 24 candidates
[00000500] main audio output debug: using audio filter module "converter_float"
[00000500] main audio output debug: TIMER module_Need() : 5,119 ms - Total 5,119 ms / 1 intvls (Avg 5,119 ms)
[00000495] main audio output debug: found a filter for the whole conversion
[00000495] main audio output debug: filter(s) 'fl32'->'fl32' 24255 Hz->22050 Hz Mono->Mono
[00000531] main audio output debug: looking for audio filter module: 24 candidates
[00000531] main audio output debug: using audio filter module "bandlimited_resampler"
[00000531] main audio output debug: TIMER module_Need() : 0,483 ms - Total 0,483 ms / 1 intvls (Avg 0,483 ms)
[00000495] main audio output debug: found a filter for the whole conversion
[00000493] x11 video output debug: XShm video extension v1.1 (with pixmaps, opcode: 144)
[00000493] x11 video output debug: Window manager supports NetWM
[00000493] x11 video output debug: Window manager supports _NET_WM_STATE_FULLSCREEN
[00000493] x11 video output debug: Window manager supports _NET_WM_STATE_ABOVE
[00000493] x11 video output debug: Window manager supports _NET_WM_STATE_BELOW
[00000493] x11 video output debug: Window manager supports _NET_WM_STATE_STAYS_ON_TOP
[00000493] main video output debug: using video output module "x11"
[00000493] main video output debug: TIMER module_Need() : 276,260 ms - Total 276,260 ms / 1 intvls (Avg 276,260 ms)
[00000493] main video output debug: waiting for thread initialization
[00000493] main video output debug: thread started
[00000493] x11 video output debug: x11 image size 320x240 (0,0,320x240)
[00000493] main video output debug: got 2 direct buffer(s)
[00000493] main video output debug: picture in 320x240 (0,0,320x240), chroma I420, ar 4:3, sar 1:1
[00000493] main video output debug: picture user 320x240 (0,0,320x240), chroma I420, ar 4:3, sar 1:1
[00000493] main video output debug: picture out 320x240 (0,0,320x240), chroma RV32, ar 4:3, sar 1:1
[00000532] main chroma debug: looking for video filter2 module: 19 candidates
[00000532] swscale chroma debug: 320x240 chroma: I420 -> 320x240 chroma: RV32 with scaling using Bicubic (good quality)
[00000532] main chroma debug: using video filter2 module "swscale"
[00000532] main chroma debug: TIMER module_Need() : 5,087 ms - Total 5,087 ms / 1 intvls (Avg 5,087 ms)
[00000493] main video output debug: indirect render, mapping render pictures 0-7 to system pictures 2-9
[00000493] main video output debug: thread 2899106704 (video output) created at priority 15 (video_output/video_output.c:502)
[00000532] main chroma debug: removing module "swscale"
[00000493] x11 video output debug: x11 image size 320x240 (0,0,320x240)
[00000403] qt4 interface debug: New Event: type 1109
[00000536] main chroma debug: looking for video filter2 module: 19 candidates
[00000536] swscale chroma debug: 320x240 chroma: I420 -> 320x240 chroma: RV32 with scaling using Bicubic (good quality)
[00000536] main chroma debug: using video filter2 module "swscale"
[00000536] main chroma debug: TIMER module_Need() : 1,605 ms - Total 1,605 ms / 1 intvls (Avg 1,605 ms)
[00000493] main video output warning: late picture skipped (111298)
[00000493] main video output warning: late picture skipped (78921)
[00000493] main video output warning: late picture skipped (46234)
[00000493] main video output warning: late picture skipped (12506)
[00000368] main playlist debug: incoming request - stopping current input
[00000368] main playlist debug: dying input
[00000001] main libvlc debug: removing all interfaces
[00000403] qt4 interface debug: Quitting the Qt4 Interface
[00000403] qt4 interface debug: Destroying the main interface
[00000459] avcodec decoder debug: ffmpeg codec (Flash Video) stopped
[00000459] main decoder debug: removing module "avcodec"
[00000459] main decoder debug: thread ended
[00000406] main input debug: control type=0
[00000406] main input debug: control: stopping input
[00000416] main demux debug: removing module "avformat"
[00000492] avcodec decoder debug: ffmpeg codec (MPEG Audio layer 1/2/3) stopped
[00000492] main decoder debug: removing module "avcodec"
[00000492] main decoder debug: thread ended
[00000412] main access debug: removing module "access_file"
[00000459] main decoder debug: thread 2925525904 joined (input/decoder.c:248)
[00000459] main decoder debug: killing decoder fourcc `FLV1', 1 PES in FIFO
[00000368] main playlist debug: dying input
[00000493] main video output warning: late picture skipped (12279)
[00000368] main playlist debug: dying input
[00000368] main playlist debug: dying input
[00000536] main chroma debug: removing module "swscale"
[00000493] main video output debug: thread ended
[00000493] main video output debug: thread 2899106704 joined (video_output/video_output.c:536)
[00000493] main video output debug: removing module "x11"
[00000492] main decoder debug: thread 2916940688 joined (input/decoder.c:248)
[00000492] main decoder debug: killing decoder fourcc `mp3 ', 1 PES in FIFO
[00000500] main audio output debug: removing module "converter_float"
[00000531] main audio output debug: removing module "bandlimited_resampler"
[00000495] main audio output debug: thread ended
[00000495] main audio output debug: thread 2907974544 joined (alsa.c:742)
[00000495] main audio output debug: removing module "alsa"
[00000495] main audio output debug: removing module "float32_mixer"
[00000406] main input debug: thread ended
[00000368] main playlist debug: dead input
[00000406] main input debug: thread 2972711824 joined (playlist/engine.c:244)
[00000403] qt4 interface debug: Destroying the Dialog Provider
[00000406] main input debug: TIMER input launching for 'wir_sind_helden-streichelzoo.flv' : 210,547 ms - Total 210,547 ms / 1 intvls (Avg 210,547 ms)
[00000403] main interface debug: thread ended
[00000403] main interface debug: thread 2982955920 joined (interface/interface.c:188)
[00000403] main interface debug: removing module "qt4"
[00000401] main interface debug: thread ended
[00000401] main interface debug: thread 3005860752 joined (interface/interface.c:188)
[00000401] main interface debug: removing module "signals"
[00000399] main interface debug: thread ended
[00000399] main interface debug: thread 3022646160 joined (interface/interface.c:188)
[00000399] main interface debug: removing module "screensaver"
[00000397] main interface debug: thread ended
[00000397] main interface debug: thread 3031038864 joined (interface/interface.c:188)
[00000397] main interface debug: removing module "inhibit"
[00000395] main interface debug: thread ended
[00000395] main interface debug: thread 3039431568 joined (interface/interface.c:188)
[00000395] main interface debug: removing module "hotkeys"
[00000001] main libvlc debug: removing all services discovery tasks
[00000001] main libvlc debug: removing playlist
[00000368] main playlist debug: saving Medienbibliothek to file /home/krasnoj/.local/share/vlc/ml.xspf
[00000368] main playlist debug: looking for playlist export module: 1 candidate
[00000368] main playlist debug: using playlist export module "export"
[00000368] main playlist debug: TIMER module_Need() : 0,937 ms - Total 0,937 ms / 1 intvls (Avg 0,937 ms)
[00000368] main playlist debug: removing module "export"
[00000393] main preparser debug: thread ended
[00000393] main preparser debug: thread 3070266256 joined (playlist/engine.c:521)
[00000394] main fetcher debug: thread ended
[00000394] main fetcher debug: thread 3056216976 joined (playlist/engine.c:523)
[00000368] main playlist debug: thread ended
[00000368] main playlist debug: thread 3047824272 joined (libvlc.c:993)
[00000393] main preparser debug: Destroyed
[00000394] main fetcher debug: Destroyed
[00000368] main playlist debug: Destroyed
[00000001] main libvlc debug: removing interaction
[00000367] main interaction debug: thread ended
[00000367] main interaction debug: thread 3078658960 joined (interface/interaction.c:400)
[00000001] main libvlc debug: removing all video outputs
[00000001] main libvlc debug: TIMER ML Load : Total 11,523 ms / 1 intvls (Avg 11,523 ms)
[00000001] main libvlc debug: TIMER Items array build : Total 0,180 ms / 2 intvls (Avg 0,090 ms)
[00000001] main libvlc debug: TIMER ML Dump : Total 1,307 ms / 1 intvls (Avg 1,307 ms)
[00000001] main libvlc debug: removing stats
[00000001] main libvlc debug: removing module "memcpymmxext"
[00000001] main libvlc debug: opening config file (/home/krasnoj/.config/vlc/vlcrc)
[00000001] main libvlc debug: opening config file (/home/krasnoj/.config/vlc/vlcrc)
[00000001] main libvlc debug: writing plugins cache /home/krasnoj/.cache/vlc/plugins-04041e.dat