This denotes repeating pattern: ########### ... "whats repeating" ########### %·> vlc -vvv VLC media player 2.0.1 Twoflower (revision 2.0.1-0-gf432547) [0x9b158b0] main libvlc debug: VLC media player - 2.0.1 Twoflower [0x9b158b0] main libvlc debug: Copyright © 1996-2012 VLC authors and VideoLAN [0x9b158b0] main libvlc debug: revision 2.0.1-0-gf432547 [0x9b158b0] main libvlc debug: configured with ./configure '--prefix=/usr' '--build=i686-pc-linux-gnu' '--host=i686-pc-linux-gnu' '--mandir=/usr/share/man' '--infodir=/usr/share/info' '--datadir=/usr/share' '--sysconfdir=/etc' '--localstatedir=/var/lib' '--disable-dependency-tracking' '--docdir=/usr/share/doc/vlc-2.0.1' '--enable-a52' '--disable-aa' '--enable-faad' '--enable-alsa' '--disable-altivec' '--disable-atmo' '--disable-audioqueue' '--disable-bonjour' '--enable-avcodec' '--enable-avformat' '--enable-fribidi' '--disable-bluray' '--enable-vcd' '--enable-libcddb' '--enable-dbus' '--enable-dbus-control' '--disable-dirac' '--disable-direct2d' '--enable-directfb' '--disable-directx' '--disable-dc1394' '--disable-debug' '--disable-dshow' '--enable-dca' '--enable-dvbpsi' '--enable-dvdread' '--enable-dvdnav' '--disable-dxva2' '--disable-egl' '--enable-sout' '--disable-fbosd' '--enable-flac' '--disable-fluidsynth' '--disable-fontconfig' '--enable-libgcrypt' '--disable-gme' '--enable-gnomevfs' '--enable-gnutls' '--disable-growl' '--enable-httpd' '--disable-dv' '--disable-ios-vout' '--disable-jack' '--disable-kate' '--without-kde-solid' '--disable-libass' '--disable-caca' '--enable-notify' '--disable-libproxy' '--disable-samplerate' '--disable-libtar' '--disable-tiger' '--disable-linsys' '--disable-lirc' '--disable-live555' '--enable-lua' '--disable-macosx-audio' '--disable-macosx-dialog-provider' '--disable-macosx-eyetv' '--disable-macosx-qtkit' '--disable-macosx-quartztext' '--disable-macosx-vout' '--enable-mkv' '--disable-media-library' '--enable-mmx' '--disable-mod' '--enable-mad' '--enable-libmpeg2' '--disable-mtp' '--disable-mpc' '--enable-ncurses' '--disable-neon' '--enable-ogg' '--disable-omxil' '--enable-glx' '--disable-optimize-memory' '--disable-oss' '--enable-png' '--disable-portaudio' '--enable-postproc' '--disable-projectm' '--enable-pulse' '--disable-pvr' '--enable-qt4' '--disable-realrtsp' '--disable-run-as-root' '--disable-smb' '--disable-schroedinger' '--enable-sdl' '--disable-sdl-image' '--disable-shine' '--disable-sid' '--disable-shout' '--enable-skins2' '--disable-speex' '--disable-sqlite' '--enable-sse' '--enable-svg' '--disable-switcher' '--enable-swscale' '--enable-taglib' '--enable-theora' '--enable-freetype' '--disable-twolame' '--enable-udev' '--disable-upnp' '--enable-v4l2' '--disable-libva' '--disable-vcdx' '--enable-vlm' '--enable-vorbis' '--disable-waveout' '--enable-loader' '--disable-wingdi' '--disable-wma-fixed' '--with-x' '--enable-x264' '--enable-xcb' '--enable-libxml2' '--enable-xosd' '--enable-xvideo' '--disable-zvbi' '--enable-telx' '--disable-optimizations' '--without-tuning' '--enable-fast-install' 'build_alias=i686-pc-linux-gnu' 'host_alias=i686-pc-linux-gnu' 'CFLAGS=-O2 -march=pentium-m -fomit-frame-pointer' 'LDFLAGS=-Wl,-O1 -Wl,--as-needed' 'CXXFLAGS=-O2 -march=pentium-m -fomit-frame-pointer' [0x9b158b0] main libvlc debug: searching plug-in modules [0x9b158b0] main libvlc debug: loading plugins cache file /usr/lib/vlc/plugins/plugins.dat [0x9b158b0] main libvlc debug: recursively browsing `/usr/lib/vlc/plugins' [0x9b158b0] main libvlc debug: saving plugins cache /usr/lib/vlc/plugins/plugins.dat [0x9b158b0] main libvlc debug: plug-ins loaded: 382 modules [0x9b158b0] main libvlc debug: opening config file (/home/a/.config/vlc/vlcrc) [0x9b158b0] main libvlc debug: translation test: code is "C" [0x9b158b0] main libvlc debug: No Media Player is running. Continuing normally. [0x9b158b0] main libvlc debug: CPU has capabilities MMX MMXEXT SSE SSE2 FPU [0x9b158b0] main libvlc debug: looking for memcpy module: 4 candidates [0x9b158b0] main libvlc debug: using memcpy module "memcpymmxext" [0x9b24f40] main input debug: Creating an input for 'Media Library' [0x9b24f40] main input debug: Input is a meta file: disabling unneeded options [0x9b24f40] main input debug: using timeshift granularity of 50 MiB, in path '/tmp' [0x9b24f40] main input debug: `file/xspf-open:///home/a/.local/share/vlc/ml.xspf' gives access `file' demux `xspf-open' path `/home/a/.local/share/vlc/ml.xspf' [0x9b24f40] main input debug: creating demux: access='file' demux='xspf-open' location='/home/a/.local/share/vlc/ml.xspf' file='/home/a/.local/share/vlc/ml.xspf' [0x9b96ab0] main demux debug: looking for access_demux module: 2 candidates [0x9b96ab0] main demux debug: no access_demux module matching "file" could be loaded [0x9b96ab0] main demux debug: TIMER module_need() : 1.005 ms - Total 1.005 ms / 1 intvls (Avg 1.005 ms) [0x9b24f40] main input debug: creating access 'file' location='/home/a/.local/share/vlc/ml.xspf', path='/home/a/.local/share/vlc/ml.xspf' [0x9b984b8] main access debug: looking for access module: 2 candidates [0x9b984b8] filesystem access debug: opening file `/home/a/.local/share/vlc/ml.xspf' [0x9b984b8] main access debug: using access module "filesystem" [0x9b984b8] main access debug: TIMER module_need() : 1.134 ms - Total 1.134 ms / 1 intvls (Avg 1.134 ms) [0x9b994a8] main stream debug: Using stream method for AStream* [0x9b994a8] main stream debug: starting pre-buffering [0x9b994a8] main stream debug: received first data after 8 ms [0x9b994a8] main stream debug: pre-buffering done 296 bytes in 0s - 34 KiB/s [0x9b98d08] main stream debug: looking for stream_filter module: 7 candidates [0x9b98d08] main stream debug: no stream_filter module matching "any" could be loaded [0x9b98d08] main stream debug: TIMER module_need() : 67.557 ms - Total 67.557 ms / 1 intvls (Avg 67.557 ms) [0x9b98d08] main stream debug: looking for stream_filter module: 1 candidate [0x9b98d08] main stream debug: using stream_filter module "stream_filter_record" [0x9b98d08] main stream debug: TIMER module_need() : 16.582 ms - Total 16.582 ms / 1 intvls (Avg 16.582 ms) [0x9b24f40] main input debug: creating demux: access='file' demux='xspf-open' location='/home/a/.local/share/vlc/ml.xspf' file='/home/a/.local/share/vlc/ml.xspf' [0x9b99820] main demux debug: looking for demux module: 1 candidate [0x9b99820] playlist demux debug: using XSPF playlist reader [0x9b99820] main demux debug: using demux module "playlist" [0x9b99820] main demux debug: TIMER module_need() : 0.484 ms - Total 0.484 ms / 1 intvls (Avg 0.484 ms) [0x9b9bc18] main demux meta debug: looking for meta reader module: 2 candidates [0x9b9bc18] lua demux meta debug: Trying Lua scripts in /home/a/.local/share/vlc/lua/meta/reader [0x9b9bc18] lua demux meta debug: Trying Lua scripts in /usr/lib/vlc/lua/meta/reader [0x9b9bc18] lua demux meta debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/reader/filename.luac [0x9b9bc18] lua demux meta debug: Trying Lua scripts in /usr/share/vlc/lua/meta/reader [0x9b9bc18] main demux meta debug: no meta reader module matching "any" could be loaded [0x9b9bc18] main demux meta debug: TIMER module_need() : 80.189 ms - Total 80.189 ms / 1 intvls (Avg 80.189 ms) [0x9b24f40] main input debug: `file/xspf-open:///home/a/.local/share/vlc/ml.xspf' successfully opened [0x9ba85a8] main xml reader debug: looking for xml reader module: 1 candidate [0x9ba85a8] main xml reader debug: using xml reader module "xml" [0x9ba85a8] main xml reader debug: TIMER module_need() : 16.760 ms - Total 16.760 ms / 1 intvls (Avg 16.760 ms) [0x9b99820] playlist demux debug: parsed 0 tracks successfully [0x9b24f40] main input debug: EOF reached [0x9b99820] main demux debug: removing module "playlist" [0x9b98d08] main stream debug: removing module "stream_filter_record" [0x9b984b8] main access debug: removing module "filesystem" [0x9b24f40] main input debug: TIMER input launching for 'Media Library' : 178.229 ms - Total 178.229 ms / 1 intvls (Avg 178.229 ms) [0x9b994a8] main interface debug: looking for interface module: 1 candidate [0x9b994a8] main interface debug: using interface module "hotkeys" [0x9b994a8] main interface debug: TIMER module_need() : 2.435 ms - Total 2.435 ms / 1 intvls (Avg 2.435 ms) [0x9b99820] main interface debug: looking for interface module: 1 candidate [0x9b99820] dbus interface: listening on dbus as: org.mpris.MediaPlayer2.vlc [0x9b92648] main playlist debug: playlist threads correctly activated [0x9b99820] dbus interface debug: Adding dbus watch on fd 6 [0x9b99820] dbus interface debug: Watching fd 6 for writeability [0x9b99820] dbus interface debug: Adding dbus watch on fd 6 [0x9b99820] dbus interface debug: Watching fd 6 for readability [0x9b99820] main interface debug: using interface module "dbus" [0x9b99820] main interface debug: TIMER module_need() : 4.413 ms - Total 4.413 ms / 1 intvls (Avg 4.413 ms) [0x9b94ef8] main interface debug: looking for interface module: 1 candidate [0x9b99820] dbus interface debug: 4 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9b92648] main playlist debug: rebuilding array of current - root Playlist [0x9b92648] main playlist debug: rebuild done - 0 items, index -1 [0x9b94ef8] main interface debug: using interface module "inhibit" [0x9b94ef8] main interface debug: TIMER module_need() : 5.310 ms - Total 5.310 ms / 1 intvls (Avg 5.310 ms) [0x9b96958] main interface debug: looking for interface module: 1 candidate [0x9b96958] main interface debug: using interface module "globalhotkeys" [0x9b96958] main interface debug: TIMER module_need() : 47.340 ms - Total 47.340 ms / 1 intvls (Avg 47.340 ms) [0x9b158b0] main libvlc: Running vlc with the default interface. Use 'cvlc' to use vlc without interface. [0x9ba79f0] main interface debug: looking for interface module: 6 candidates [0x9c58be0] main generic debug: looking for extension module: 1 candidate [0x9c58be0] lua generic debug: Opening Lua Extension module [0x9c58be0] lua generic debug: Trying Lua scripts in /home/a/.local/share/vlc/lua/extensions [0x9c58be0] lua generic debug: Trying Lua scripts in /usr/lib/vlc/lua/extensions [0x9c58be0] lua generic debug: Trying Lua scripts in /usr/share/vlc/lua/extensions [0x9c58be0] main generic debug: using extension module "lua" [0x9c58be0] main generic debug: TIMER module_need() : 6.048 ms - Total 6.048 ms / 1 intvls (Avg 6.048 ms) [0x9c99cf0] main probe debug: looking for services probe module: 7 candidates [0x9c99cf0] main probe debug: no services probe module matching "any" could be loaded [0x9c99cf0] main probe debug: TIMER module_need() : 240.294 ms - Total 240.294 ms / 1 intvls (Avg 240.294 ms) [0x9ba79f0] qt4 interface debug: Normal PL/ML or SD [0x9ba79f0] qt4 interface debug: Normal PL/ML or SD [0x9ba79f0] main interface debug: using interface module "qt4" [0x9ba79f0] main interface debug: TIMER module_need() : 1722.747 ms - Total 1722.747 ms / 1 intvls (Avg 1722.747 ms) [0x9b92648] main playlist debug: adding item `shrek1.iso' ( file:///home/a/Videos/shrek1.iso ) [0x9b99820] dbus interface debug: Got a VLC event on playlist-item-append. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b92648] main playlist debug: rebuilding array of current - root Playlist [0x9b92648] main playlist debug: rebuild done - 1 items, index -1 [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: Dispatching incoming dbus message [0x9b99820] dbus interface debug: Dispatching incoming dbus message [0x9b99820] dbus interface debug: DBus dispatch status changed to COMPLETE. [0x9b99820] dbus interface debug: 5013522 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9ba79f0] qt4 interface debug: Adding a new MRL to recent ones: file:///home/a/Videos/shrek1.iso [0x9c0b528] main input debug: Creating an input for 'shrek1.iso' [0x9b92648] main playlist debug: meta ok for (null), need to fetch art [0x9c0b528] main demux meta debug: looking for meta fetcher module: 1 candidate [0x9c0b528] lua demux meta debug: Trying Lua scripts in /home/a/.local/share/vlc/lua/meta/fetcher [0x9c0b528] lua demux meta debug: Trying Lua scripts in /usr/lib/vlc/lua/meta/fetcher [0x9c0b528] lua demux meta debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/fetcher/tvrage.luac [0x9c0b528] main demux meta debug: using meta fetcher module "lua" [0x9c0b528] main demux meta debug: TIMER module_need() : 8.891 ms - Total 8.891 ms / 1 intvls (Avg 8.891 ms) [0x9c0b528] main demux meta debug: removing module "lua" [0x9b92648] main playlist debug: searching art for shrek1.iso [0x9c0b528] main art finder debug: looking for art finder module: 2 candidates [0x9c0b528] lua art finder debug: Trying Lua scripts in /home/a/.local/share/vlc/lua/meta/art [0x9c0b528] lua art finder debug: Trying Lua scripts in /usr/lib/vlc/lua/meta/art [0x9c0b528] lua art finder debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/art/00_musicbrainz.luac [0x9c0b528] lua art finder debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/art/01_googleimage.luac [0x9c0b528] lua art finder debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/art/02_frenchtv.luac [0x9c0b528] lua art finder debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/art/03_lastfm.luac [0x9c0b528] lua art finder debug: Trying Lua scripts in /usr/share/vlc/lua/meta/art [0x9c0b528] main art finder debug: no art finder module matching "any" could be loaded [0x9c0b528] main art finder debug: TIMER module_need() : 8.951 ms - Total 8.951 ms / 1 intvls (Avg 8.951 ms) [0x9b92648] main playlist debug: art not found for shrek1.iso [0x9b92648] main playlist debug: processing request item: null, node: Playlist, skip: 0 [0x9b92648] main playlist debug: starting playback of the new playlist item [0x9b92648] main playlist debug: creating new input thread [0x9bff598] main input debug: Creating an input for 'shrek1.iso' [0x9ba79f0] qt4 interface debug: IM: Setting an input [0x9b99820] dbus interface debug: Got a VLC event on item-current. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 8597292 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9bff598] main input debug: using timeshift granularity of 50 MiB, in path '/tmp' [0x9b99820] dbus interface debug: Got a VLC event on intf-event. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 8443 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9bff598] main input debug: `file:///home/a/Videos/shrek1.iso' gives access `file' demux `' path `/home/a/Videos/shrek1.iso' [0x9bff598] main input debug: creating demux: access='file' demux='' location='/home/a/Videos/shrek1.iso' file='/home/a/Videos/shrek1.iso' [0x9d0ba98] main demux debug: looking for access_demux module: 2 candidates libdvdnav: Using dvdnav version 4.2.0 libdvdread: Using libdvdcss version 1.2.11 for DVD access libdvdnav: DVD Title: SHREK1 libdvdnav: DVD Serial Number: 012FC9F5DVDSHRNK libdvdnav: DVD Title (Alternative): libdvdnav: Unable to find map file '/home/a/.dvdnav/SHREK1.map' libdvdnav: DVD disk reports itself with Region mask 0x00c00000. Regions: 1 2 3 4 5 6 libdvdread: Attempting to retrieve all CSS keys libdvdread: This can take a _long_ time, please be patient libdvdread: Get key for /VIDEO_TS/VIDEO_TS.VOB at 0x00000139 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_01_0.VOB at 0x000001ab libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_01_1.VOB at 0x0001a15f libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_02_0.VOB at 0x001b8dc4 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_02_1.VOB at 0x001b8df9 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_03_0.VOB at 0x001c43c0 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_03_1.VOB at 0x001c43f5 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_04_0.VOB at 0x001cc87a libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_04_1.VOB at 0x001cc8b0 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_05_0.VOB at 0x001cdcb8 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_05_1.VOB at 0x001cdcee libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_06_0.VOB at 0x0021bad6 libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_06_1.VOB at 0x0021bb0c libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_07_0.VOB at 0x00222b3c libdvdread: Elapsed time 0 libdvdread: Get key for /VIDEO_TS/VTS_07_1.VOB at 0x00222b72 libdvdread: Elapsed time 0 libdvdread: Found 7 VTS's libdvdread: Elapsed time 0 [0x9d0ba98] dvdnav demux debug: trying to go to dvd menu [0x9d0ba98] main demux debug: using access_demux module "dvdnav" [0x9d0ba98] main demux debug: TIMER module_need() : 80.085 ms - Total 80.085 ms / 1 intvls (Avg 80.085 ms) [0x9b99820] dbus interface debug: Got a VLC event on can-pause. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 88100 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9b99820] dbus interface debug: Got a VLC event on can-seek. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 374 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9bff598] main input debug: looking for a subtitle file in /home/a/Videos [0x9d4e988] main demux meta debug: looking for meta reader module: 2 candidates [0x9d4e988] lua demux meta debug: Trying Lua scripts in /home/a/.local/share/vlc/lua/meta/reader [0x9d4e988] lua demux meta debug: Trying Lua scripts in /usr/lib/vlc/lua/meta/reader [0x9d4e988] lua demux meta debug: Trying Lua playlist script /usr/lib/vlc/lua/meta/reader/filename.luac [0x9d4e988] lua demux meta debug: Trying Lua scripts in /usr/share/vlc/lua/meta/reader [0x9d4e988] main demux meta debug: no meta reader module matching "any" could be loaded [0x9d4e988] main demux meta debug: TIMER module_need() : 4.007 ms - Total 4.007 ms / 1 intvls (Avg 4.007 ms) [0x9b99820] dbus interface debug: Got a VLC event on intf-event. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 11183 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9bff598] main input debug: `file:///home/a/Videos/shrek1.iso' successfully opened [0x9d0ba98] dvdnav demux debug: DVDNAV_HOP_CHANNEL [0x9bff598] main input error: ES_OUT_RESET_PCR called [0x9d0ba98] dvdnav demux debug: DVDNAV_VTS_CHANGE [0x9d0ba98] dvdnav demux debug: - vtsN=1 [0x9d0ba98] dvdnav demux debug: - domain=8 [0x9bff598] main input error: ES_OUT_RESET_PCR called [0x9d0ba98] dvdnav demux debug: DVDNAV_CELL_CHANGE [0x9d0ba98] dvdnav demux debug: - cellN=1 [0x9d0ba98] dvdnav demux debug: - pgN=1 [0x9d0ba98] dvdnav demux debug: - cell_length=2833200 [0x9d0ba98] dvdnav demux debug: - pg_length=2833200 [0x9d0ba98] dvdnav demux debug: - pgc_length=2833200 [0x9d0ba98] dvdnav demux debug: - cell_start=0 [0x9d0ba98] dvdnav demux debug: - pg_start=0 [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_CLUT_CHANGE [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_STREAM_CHANGE [0x9d0ba98] dvdnav demux debug: - physical_wide=0 [0x9d0ba98] dvdnav demux debug: - physical_letterbox=1 [0x9d0ba98] dvdnav demux debug: - physical_pan_scan=0 [0x9d0ba98] dvdnav demux debug: buttonUpdate not done b=1 t=0 [0x9bff598] main input debug: selecting program id=0 [0x9b99820] dbus interface debug: Got a VLC event on intf-event. The main loop needs to wake up in order to process it [0x9b99820] dbus interface debug: Sending wakeup signal to the main loop [0x9b99820] dbus interface debug: the main loop has been woken up [0x9b99820] dbus interface debug: Removing a byte from the self-pipe [0x9b99820] dbus interface debug: Nothing happened on fd 6 [0x9b99820] dbus interface debug: 4301 µs elapsed since last wakeup [0x9b99820] dbus interface debug: Sleeping until something happens [0x9d513a0] main decoder debug: looking for decoder module: 26 candidates [0x9ba79f0] qt4 interface debug: Title 8 [0x9ba79f0] qt4 interface debug: Chapter: 7 [0x9d513a0] main decoder debug: using decoder module "spudec" [0x9d513a0] main decoder debug: TIMER module_need() : 66.940 ms - Total 66.940 ms / 1 intvls (Avg 66.940 ms) [0x9d513a0] spudec decoder debug: invalid starting packet (size < 4 or pts <=0) [0x9d513a0] spudec decoder debug: spu size: 0, i_pts: 0 i_buffer: 128 [0x9d0ba98] dvdnav demux debug: DVDNAV_AUDIO_STREAM_CHANGE [0x9d0ba98] dvdnav demux debug: - physical=0 [0x9bff598] main input debug: Buffering 0% [0x9d0ba98] dvdnav demux debug: buttonUpdate 1 [0x9bff598] main input debug: Buffering 0% [0x9d80840] main decoder debug: looking for decoder module: 26 candidates [0x9d80840] avcodec decoder debug: libavcodec initialized (interface 0x347b00) [0x9d80840] avcodec decoder debug: trying to use direct rendering [0x9d80840] avcodec decoder debug: allowing 1 thread(s) for decoding [0x9d80840] avcodec decoder debug: ffmpeg codec (MPEG-1/2 Video) started [0x9d80840] main decoder debug: using decoder module "avcodec" [0x9d80840] main decoder debug: TIMER module_need() : 22.055 ms - Total 22.055 ms / 1 intvls (Avg 22.055 ms) [0x9d81250] main packetizer debug: looking for packetizer module: 20 candidates [0x9d81250] main packetizer debug: using packetizer module "packetizer_mpegvideo" [0x9d81250] main packetizer debug: TIMER module_need() : 4.904 ms - Total 4.904 ms / 1 intvls (Avg 4.904 ms) [0x9d0ba98] dvdnav demux debug: buttonUpdate 1 [0x9bff598] main input debug: Buffering 1% [0x9bff598] main input debug: Buffering 1% [0x9bff598] main input debug: idx1=-1(??) idx2=-1(??) [0x9bff598] main input debug: Buffering 5% [0x9bff598] main input debug: Buffering 6% [0x9bff598] main input debug: Buffering 7% [0x9bff598] main input debug: Buffering 7% [0x9d81250] packetizer_mpegvideo packetizer debug: size 720x576 fps=25.000 [0x9bff598] main input debug: Buffering 8% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 31% [0x9d7fb48] main spu text debug: looking for text renderer module: 3 candidates [0x9d7fb48] freetype spu text error: failed to load font file DejaVu Sans [0x9bff598] main input debug: Buffering 31% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 35% [0x9d7b5b8] main decoder debug: looking for decoder module: 26 candidates [0x9d7b5b8] main decoder debug: using decoder module "a52" [0x9d7b5b8] main decoder debug: TIMER module_need() : 0.446 ms - Total 0.446 ms / 1 intvls (Avg 0.446 ms) [0x9bff598] main input debug: Buffering 36% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 68% [0x9d7b5b8] a52 decoder debug: A/52 channels:2 samplerate:48000 bitrate:192000 [0x9bff598] main input debug: Buffering 69% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 88% [0x9bff598] main input debug: Stream buffering done (344 ms in 83 ms) [0x9d7fb48] main spu text debug: using text renderer module "svg" [0x9d7fb48] main spu text debug: TIMER module_need() : 75.654 ms - Total 75.654 ms / 1 intvls (Avg 75.654 ms) [0x9d783f8] main scale debug: looking for video filter2 module: 18 candidates [0x9d783f8] swscale scale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality) [0x9d783f8] main scale debug: using video filter2 module "swscale" [0x9d783f8] main scale debug: TIMER module_need() : 7.619 ms - Total 7.619 ms / 1 intvls (Avg 7.619 ms) [0x9e601a8] main scale debug: looking for video filter2 module: 18 candidates [0x9e601a8] yuvp scale debug: YUVP to YUVA converter [0x9e601a8] main scale debug: using video filter2 module "yuvp" [0x9e601a8] main scale debug: TIMER module_need() : 13.930 ms - Total 13.930 ms / 1 intvls (Avg 13.930 ms) [0x9df5d08] main video output debug: Deinterlacing available [0x9df5d08] main video output debug: deinterlace -1, mode blend, is_needed 0 [0x9df5d08] main video output debug: Opening vout display wrapper [0x9e7a460] main vout display debug: looking for vout display module: 6 candidates [0x9e7d938] main window debug: looking for vout window xid module: 4 candidates [0x9e7d938] qt4 window debug: requesting video... [0x9ba79f0] qt4 interface debug: Video was requested 0, 0 [0x9e7d938] main window debug: using vout window xid module "qt4" [0x9e7d938] main window debug: TIMER module_need() : 80.572 ms - Total 80.572 ms / 1 intvls (Avg 80.572 ms) [0x9e7dd68] main inhibit debug: looking for inhibit module: 2 candidates [0x9e7dd68] main inhibit debug: using inhibit module "xdg_screensaver" [0x9e7dd68] main inhibit debug: TIMER module_need() : 4.077 ms - Total 4.077 ms / 1 intvls (Avg 4.077 ms) [0x9e7dd68] xdg_screensaver inhibit debug: started xdg-screensaver (PID = 8428) [0x9e7a460] xcb_xv vout display debug: connected to X11.0 server [0x9e7a460] xcb_xv vout display debug: vendor : The X.Org Foundation [0x9e7a460] xcb_xv vout display debug: version: 11102000 [0x9e7a460] xcb_xv vout display debug: using screen 0x142 [0x9e7a460] xcb_xv vout display debug: using XVideo extension v2.2 [0x9e7a460] xcb_xv vout display debug: using adaptor SIS 300/315/330 series Video Overlay [0x9e7a460] xcb_xv vout display debug: using port 62 [0x9e7a460] xcb_xv vout display debug: using image format 0x30323449 [0x9e7a460] xcb_xv vout display debug: using X11 visual ID 0x21 (depth: 24) [0x9e7a460] xcb_xv vout display debug: using X11 window 0x03400000 [0x9e7a460] xcb_xv vout display debug: using X11 graphic context 0x03400002 [0x9e7a460] main vout display debug: VoutDisplayEvent 'fullscreen' 0 [0x9e7a460] main vout display debug: VoutDisplayEvent 'resize' 1024x576 window [0x9e7a460] main vout display debug: using vout display module "xcb_xv" [0x9e7a460] main vout display debug: TIMER module_need() : 357.331 ms - Total 357.331 ms / 1 intvls (Avg 357.331 ms) [0x9df5d08] main video output debug: original format sz 720x576, of (0,0), vsz 720x576, 4cc I420, sar 64:45, msk r0x0 g0x0 b0x0 [0x9bff598] main input debug: crop: 134,455,71,65, palette forced: 1 [0x9d7fb48] main spu text debug: removing module "svg" [0x9d7fb48] main spu text debug: looking for text renderer module: 3 candidates [0x9d7fb48] freetype spu text error: failed to load font file DejaVu Sans [0x9d7fb48] main spu text debug: using text renderer module "svg" [0x9d7fb48] main spu text debug: TIMER module_need() : 4.055 ms - Total 4.055 ms / 1 intvls (Avg 4.055 ms) [0x9d80840] avcodec decoder debug: using direct rendering [0x9b92648] main playlist debug: creating audio output [0x9e85948] main audio output debug: looking for audio output module: 2 candidates [0x9e85948] pulse audio output debug: using stereo channel map [0x9e85948] pulse audio output debug: using library version 1.1.0 [0x9e85948] pulse audio output debug: (compiled with version 1.1.0, protocol 23) [0x9e85948] pulse audio output debug: connected locally to unix:/home/a/.pulse/aff07c49c7444ba2008bb92000005a70-runtime/native as client #12 [0x9e85948] pulse audio output debug: using protocol 23, server protocol 23 [0x9e85948] pulse audio output debug: digital pass-through not available [0x9e85948] pulse audio output debug: using buffer metrics: maxlength=4194304, tlength=21504, prebuf=0, minreq=7680 [0x9e85948] pulse audio output debug: connected to sink 0: alsa_output.pci-0000_00_02.7.analog-stereo [0x9e85948] main audio output debug: using audio output module "pulse" [0x9e85948] main audio output debug: TIMER module_need() : 57.289 ms - Total 57.289 ms / 1 intvls (Avg 57.289 ms) [0x9e85948] main audio output debug: output 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes [0x9e85948] main audio output debug: mixer 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes [0x9e85948] main audio output debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo [0x9e85948] main audio output debug: conversion pipeline completed [0x9e8dea8] main mixer debug: looking for audio mixer module: 2 candidates [0x9e8dea8] main mixer debug: using audio mixer module "float32_mixer" [0x9e8dea8] main mixer debug: TIMER module_need() : 5.814 ms - Total 5.814 ms / 1 intvls (Avg 5.814 ms) [0x9e85948] pulse audio output debug: listing sink alsa_output.pci-0000_00_02.7.analog-stereo (0): Internal Audio Analog Stereo [0x9e85948] main audio output debug: input 'a52 ' 48000 Hz Stereo frame=1536 samples/768 bytes [0x9e95728] main audio filter debug: looking for audio filter module: 1 candidate [0x9e95728] scaletempo audio filter debug: format: 48000 rate, 2 nch, 4 bps, fl32 [0x9e95728] scaletempo audio filter debug: params: 30 stride, 0.200 overlap, 14 search [0x9e95728] scaletempo audio filter debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode [0x9e95728] main audio filter debug: using audio filter module "scaletempo" [0x9e95728] main audio filter debug: TIMER module_need() : 12.126 ms - Total 12.126 ms / 1 intvls (Avg 12.126 ms) [0x9e85948] main audio output debug: filter(s) 'a52 '->'f32l' 48000 Hz->48000 Hz Stereo->Stereo [0x9e85948] pulse audio output debug: base volume: 41350 [0x9e94860] main audio filter debug: looking for audio filter module: 12 candidates [0x9e7a460] xcb_xv vout display debug: display is visible No accelerated IMDCT transform found [0x9e94860] main audio filter debug: using audio filter module "a52tofloat32" [0x9e94860] main audio filter debug: TIMER module_need() : 58.154 ms - Total 58.154 ms / 1 intvls (Avg 58.154 ms) [0x9e85948] main audio output debug: conversion pipeline completed [0x9e85948] main audio output debug: filter(s) 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo [0x9e85948] main audio output debug: conversion pipeline completed [0x9e85948] main audio output debug: filter(s) 'f32l'->'f32l' 52800 Hz->48000 Hz Stereo->Stereo [0x9e96020] main audio filter debug: looking for audio filter module: 12 candidates [0x9e96020] main audio filter debug: using audio filter module "ugly_resampler" [0x9e96020] main audio filter debug: TIMER module_need() : 36.702 ms - Total 36.702 ms / 1 intvls (Avg 36.702 ms) [0x9e85948] main audio output debug: conversion pipeline completed [0x9d80840] main decoder debug: End of video preroll [0x9d7b5b8] main decoder debug: End of audio preroll [0x9d80840] main decoder debug: Received first picture [0x9ef6808] main blend debug: looking for video blending module: 1 candidate [0x9ef6808] main blend debug: using video blending module "blend" [0x9ef6808] main blend debug: TIMER module_need() : 6.178 ms - Total 6.178 ms / 1 intvls (Avg 6.178 ms) [0x9df5d08] main video output debug: Post-processing available [0x9df5d08] main video output debug: Detected interlaced video [0x9df5d08] main video output debug: deinterlace -1, mode blend, is_needed 1 [0x9df5d08] main video output debug: Adding 'deinterlace' as static [0x9efb6f8] main filter debug: looking for video filter2 module: 1 candidate [0x9efb6f8] deinterlace filter debug: using blend deinterlace method [0x9efb6f8] deinterlace filter debug: deinterlacing [0x9efb6f8] main filter debug: using video filter2 module "deinterlace" [0x9efb6f8] main filter debug: TIMER module_need() : 13.730 ms - Total 13.730 ms / 1 intvls (Avg 13.730 ms) [0x9df5d08] main video output debug: Filter 'deinterlace' (0x9efb6f8) appended to chain [0x9bff598] main input debug: Decoder buffering done in 869 ms [0x9e85948] pulse audio output debug: deferring start (321402 us) [0x9e7a460] main vout display debug: auto hiding mouse cursor [0x9d859f0] main subpicture warning: original picture size is undefined [0x9e85948] pulse audio output debug: starting deferred [0x9e85948] pulse audio output debug: started [0x9e85948] pulse audio output debug: listing sink alsa_output.pci-0000_00_02.7.analog-stereo (0): Internal Audio Analog Stereo [0x9e7a460] main vout display debug: auto hiding mouse cursor [0x9df5d08] main video output warning: picture is too late to be displayed (missing 192 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 152 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 112 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 72 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 32 ms) [0x9e7a460] xcb_xv vout display debug: display is not visible [0x9e7a460] xcb_xv vout display debug: display is visible [0x9df5d08] main video output warning: picture is too late to be displayed (missing 110 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 70 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 30 ms) [0x9df5d08] main video output warning: picture is too late to be displayed (missing 28 ms) [0x9df5d08] main video output debug: picture might be displayed late (missing 5 ms) [0x9e7a460] xcb_xv vout display debug: display is visible [0x9e7a460] xcb_xv vout display debug: display is visible [0x9d0ba98] dvdnav demux debug: DVDNAV_HIGHLIGHT [0x9d0ba98] dvdnav demux debug: - display=1 [0x9d0ba98] dvdnav demux debug: - buttonN=3 [0x9bff598] main input debug: crop: 291,450,102,76, palette forced: 1 [0x9d0ba98] dvdnav demux debug: buttonUpdate 3 [0x9df5d08] main video output warning: picture is too late to be displayed (missing 39 ms) [0x9d0ba98] dvdnav demux debug: DVDNAV_HIGHLIGHT [0x9d0ba98] dvdnav demux debug: - display=1 [0x9d0ba98] dvdnav demux debug: - buttonN=1 [0x9bff598] main input debug: crop: 134,455,71,65, palette forced: 1 [0x9d0ba98] dvdnav demux debug: buttonUpdate 1 [0x9e7a460] main vout display debug: auto hiding mouse cursor [0x9e7a460] main vout display debug: VoutDisplayEvent 'mouse button' 0 t=8 [0x9bff598] main input debug: crop: 134,455,71,65, palette forced: 1 [0x9d0ba98] dvdnav demux debug: buttonUpdate 1 [0x9d0ba98] dvdnav demux debug: DVDNAV_HOP_CHANNEL [0x9bff598] main input error: ES_OUT_RESET_PCR called [0x9d513a0] spudec decoder debug: invalid starting packet (size < 4 or pts <=0) [0x9d513a0] spudec decoder debug: spu size: 0, i_pts: 0 i_buffer: 128 [0x9e85948] pulse audio output warning: underflow [0x9d0ba98] dvdnav demux debug: DVDNAV_CELL_CHANGE [0x9d0ba98] dvdnav demux debug: - cellN=1 [0x9d0ba98] dvdnav demux debug: - pgN=1 [0x9d0ba98] dvdnav demux debug: - cell_length=705600 [0x9d0ba98] dvdnav demux debug: - pg_length=705600 [0x9d0ba98] dvdnav demux debug: - pgc_length=705600 [0x9d0ba98] dvdnav demux debug: - cell_start=0 [0x9d0ba98] dvdnav demux debug: - pg_start=0 [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_CLUT_CHANGE [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_STREAM_CHANGE [0x9d0ba98] dvdnav demux debug: - physical_wide=0 [0x9d0ba98] dvdnav demux debug: - physical_letterbox=1 [0x9d0ba98] dvdnav demux debug: - physical_pan_scan=0 [0x9bff598] main input debug: crop: 134,455,71,65, palette forced: 1 [0x9d0ba98] dvdnav demux debug: buttonUpdate 1 [0x9e85948] pulse audio output debug: listing sink alsa_output.pci-0000_00_02.7.analog-stereo (0): Internal Audio Analog Stereo [0x9d513a0] main decoder debug: removing module "spudec" [0x9d513a0] main decoder debug: killing decoder fourcc `spu ', 0 PES in FIFO [0x9d513a0] main decoder debug: looking for decoder module: 26 candidates [0x9d513a0] main decoder debug: using decoder module "spudec" [0x9d513a0] main decoder debug: TIMER module_need() : 0.441 ms - Total 0.441 ms / 1 intvls (Avg 0.441 ms) [0x9d513a0] spudec decoder debug: invalid starting packet (size < 4 or pts <=0) [0x9d513a0] spudec decoder debug: spu size: 0, i_pts: 0 i_buffer: 128 [0x9d0ba98] dvdnav demux debug: DVDNAV_AUDIO_STREAM_CHANGE [0x9d0ba98] dvdnav demux debug: - physical=0 [0x9bff598] main input debug: Buffering 0% [0x9d0ba98] dvdnav demux debug: buttonUpdate not done b=1 t=0 [0x9bff598] main input debug: Buffering 0% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 38% [0x9e7a460] main vout display debug: VoutDisplayEvent 'mouse button' 0 t=9 [0x9bff598] main input debug: Buffering 39% [0x9bff598] main input debug: Buffering 39% [0x9bff598] main input debug: Buffering 40% [0x9d7b5b8] main decoder debug: End of audio preroll [0x9bff598] main input debug: Buffering 44% ########### ... repeating text about buffering ########### [0x9bff598] main input debug: Buffering 94% [0x9bff598] main input debug: Stream buffering done (344 ms in 139 ms) [0x9d80840] main decoder debug: End of video preroll [0x9d80840] main decoder debug: Received first picture [0x9bff598] main input debug: Decoder buffering done in 105 ms [0x9e85948] pulse audio output debug: deferring start (321594 us) [0x9d859f0] main subpicture warning: original picture size is undefined [0x9ef6808] main blend debug: removing module "blend" [0x9ef6808] main blend debug: looking for video blending module: 1 candidate [0x9ef6808] main blend debug: using video blending module "blend" [0x9ef6808] main blend debug: TIMER module_need() : 0.300 ms - Total 0.300 ms / 1 intvls (Avg 0.300 ms) [0x9e85948] pulse audio output debug: starting deferred [0x9e85948] pulse audio output debug: started [0x9e85948] pulse audio output debug: listing sink alsa_output.pci-0000_00_02.7.analog-stereo (0): Internal Audio Analog Stereo [0x9e7a460] main vout display debug: auto hiding mouse cursor [0x9e7a460] xcb_xv vout display debug: display is visible [0x9df5d08] main video output debug: picture might be displayed late (missing 7 ms) [0x9e7a460] xcb_xv vout display debug: display is visible [0x9e7a460] main vout display debug: auto hiding mouse cursor [0x9e7a460] xcb_xv vout display debug: display is not visible [0x9d0ba98] dvdnav demux debug: DVDNAV_NOP [0x9d0ba98] dvdnav demux debug: DVDNAV_VTS_CHANGE [0x9d0ba98] dvdnav demux debug: - vtsN=1 [0x9d0ba98] dvdnav demux debug: - domain=2 [0x9bff598] main input error: ES_OUT_RESET_PCR called [0x9d513a0] spudec decoder debug: invalid starting packet (size < 4 or pts <=0) [0x9d513a0] spudec decoder debug: spu size: 0, i_pts: 0 i_buffer: 128 [0x9d80840] main decoder debug: removing module "avcodec" [0x9d80840] avcodec decoder debug: ffmpeg codec (MPEG-1/2 Video) stopped [0x9d80840] main decoder debug: killing decoder fourcc `mpgv', 0 PES in FIFO [0x9e85948] pulse audio output warning: too early by 541932 us [0x9e85948] pulse audio output debug: changed sample rate to 47954 Hz [0x9e85948] pulse audio output warning: underflow [0x9b92648] main playlist debug: saving a free vout [0x9b92648] main playlist debug: reusing provided vout [0x9d81250] main packetizer debug: removing module "packetizer_mpegvideo" [0x9d513a0] main decoder debug: removing module "spudec" [0x9d513a0] main decoder debug: killing decoder fourcc `spu ', 0 PES in FIFO [0x9d7b5b8] main decoder debug: removing module "a52" [0x9d7b5b8] main decoder debug: killing decoder fourcc `a52 ', 0 PES in FIFO [0x9e85948] pulse audio output debug: listing sink alsa_output.pci-0000_00_02.7.analog-stereo (0): Internal Audio Analog Stereo [0x9e94860] main audio filter debug: removing module "a52tofloat32" [0x9e95728] main audio filter debug: removing module "scaletempo" [0x9e96020] main audio filter debug: removing module "ugly_resampler" [0x9e85948] main audio output debug: removing module "pulse" [0x9e8dea8] main mixer debug: removing module "float32_mixer" [0x9b92648] main playlist debug: releasing audio output [0x9bff598] main input debug: Program doesn't contain anymore ES [0x9d0ba98] dvdnav demux debug: DVDNAV_CELL_CHANGE [0x9d0ba98] dvdnav demux debug: - cellN=1 [0x9d0ba98] dvdnav demux debug: - pgN=1 [0x9d0ba98] dvdnav demux debug: - cell_length=25624800 [0x9d0ba98] dvdnav demux debug: - pg_length=25624800 [0x9d0ba98] dvdnav demux debug: - pgc_length=466452000 [0x9d0ba98] dvdnav demux debug: - cell_start=0 [0x9d0ba98] dvdnav demux debug: - pg_start=0 [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_CLUT_CHANGE [0x9d0ba98] dvdnav demux debug: DVDNAV_SPU_STREAM_CHANGE [0x9ba79f0] qt4 interface debug: Title 8 [0x9ba79f0] qt4 interface debug: Chapter: 20 [0x9d0ba98] dvdnav demux debug: - physical_wide=128 [0x9d0ba98] dvdnav demux debug: - physical_letterbox=128 [0x9d0ba98] dvdnav demux debug: - physical_pan_scan=128 [0x9d0ba98] dvdnav demux debug: buttonUpdate not done b=1 t=1 [0x9d0ba98] dvdnav demux debug: DVDNAV_AUDIO_STREAM_CHANGE [0x9d0ba98] dvdnav demux debug: - physical=0 [0x9bff598] main input debug: Buffering 0% [0x9d0ba98] dvdnav demux debug: buttonUpdate not done b=1 t=1 [0x9bff598] main input debug: Buffering 0% [0x9d7b5b8] main decoder debug: looking for decoder module: 26 candidates [0x9d7b5b8] avcodec decoder debug: libavcodec already initialized [0x9d7b5b8] avcodec decoder debug: trying to use direct rendering [0x9d7b5b8] avcodec decoder debug: allowing 1 thread(s) for decoding [0x9d7b5b8] avcodec decoder debug: ffmpeg codec (MPEG-1/2 Video) started [0x9d7b5b8] main decoder debug: using decoder module "avcodec" [0x9d7b5b8] main decoder debug: TIMER module_need() : 1.080 ms - Total 1.080 ms / 1 intvls (Avg 1.080 ms) [0x9d513a0] main packetizer debug: looking for packetizer module: 20 candidates [0x9d513a0] main packetizer debug: using packetizer module "packetizer_mpegvideo" [0x9d513a0] main packetizer debug: TIMER module_need() : 0.136 ms - Total 0.136 ms / 1 intvls (Avg 0.136 ms) [0x9d0ba98] dvdnav demux debug: buttonUpdate not done b=1 t=1 [0x9d513a0] packetizer_mpegvideo packetizer debug: size 720x576 fps=25.000 [0x9bff598] main input debug: Buffering 1% [0x9bff598] main input debug: Buffering 1% [0x9bff598] main input debug: Buffering 2% [0x9bff598] main input debug: Buffering 2% [0x9b92648] main playlist debug: trying to reuse free vout [0x9d7fb48] main spu text debug: removing module "svg" [0x9d7fb48] main spu text debug: looking for text renderer module: 3 candidates [0x9d7fb48] freetype spu text error: failed to load font file DejaVu Sans [0x9d7fb48] main spu text debug: using text renderer module "svg" [0x9d7fb48] main spu text debug: TIMER module_need() : 6.191 ms - Total 6.191 ms / 1 intvls (Avg 6.191 ms) [0x9bff598] main input debug: Buffering 13% [0x9d81250] main decoder debug: looking for decoder module: 26 candidates [0x9d81250] main decoder debug: using decoder module "a52" [0x9d81250] main decoder debug: TIMER module_need() : 8.412 ms - Total 8.412 ms / 1 intvls (Avg 8.412 ms) [0x9b92648] main playlist debug: reusing provided vout [0x9d7b5b8] avcodec decoder debug: using direct rendering [0x9bff598] main input debug: Buffering 13% [0x9bff598] main input debug: Buffering 14% [0x9d81250] a52 decoder debug: A/52 channels:6 samplerate:48000 bitrate:448000 [0x9b92648] main playlist debug: recycling audio output [0x9e85948] main audio output debug: looking for audio output module: 2 candidates [0x9e85948] pulse audio output debug: using surround-51 channel map [0x9e85948] pulse audio output debug: using library version 1.1.0 [0x9e85948] pulse audio output debug: (compiled with version 1.1.0, protocol 23) Assertion 'pthread_setspecific(t->key, userdata) == 0' failed at pulsecore/thread-posix.c:247, function pa_tls_set(). Aborting. zsh: abort vlc -vvv