The mpeg-2 TS VBR fix in 0.8.6-test1

[Tappen]

First of all, fantastic work getting this improvement in. Finally videos from my home theatre capture program show the correct length in VLC, and the commercial detection bookmark file I've integrated with a VLC ActiveX player works correctly.

I'm still having problems with videos created at a less than "normal" bitrate by my DVD recorder (LP mode for it). When I use the "skip ahead"/"skip back" functions on these files, such as if I'm at the 2:00 mark and skip ahead 1 minute with Ctrl-Right, VLC briefly moves the progress bar to 3:00 and then drops it back to 2:45. So for the files I'm having trouble with all jumps are 3/4 of what they should be, even though the total length of the files shows correctly. I believe this is the same behaviour as 0.8.5, but I thought it might get fixed along with the total length issue. Perhaps it's just these files, mpeg-2 from other sources skip ahead/back correctly.

Codec: mpgv/mpga, Stream bitrate is about 2500 kb/s

Here's an example of the Messages as I start a file in case you'd like to look into it:

main debug: adding playlist item `Z:\BeyondTV\AX\AX_1.mpg' ( Z:\BeyondTV\AX\AX_1.mpg )
main debug: creating new input thread
main debug: waiting for thread completion
main debug: drive letter Z: found in source
main debug: `Z:\BeyondTV\AX\AX_1.mpg' gives access `' demux `' path `Z:\BeyondTV\AX\AX_1.mpg'
main debug: creating demux: access='' demux='' path='Z:\BeyondTV\AX\AX_1.mpg'
main debug: looking for access_demux module: 1 candidate
main debug: thread 4528 (input) created at priority 1 (input/input.c:263)
main debug: creating access '' path='Z:\BeyondTV\AX\AX_1.mpg'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: Z:\BeyondTV\AX\AX_1.cue
access_file debug: opening file `Z:\BeyondTV\AX\AX_1.mpg'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: pre-buffering done 1408981 bytes in 0s - 41555 kbytes/s
main debug: creating demux: access='' demux='' path='Z:\BeyondTV\AX\AX_1.mpg'
main debug: looking for demux2 module: 45 candidates
main debug: using demux2 module "ps"
main debug: looking for a subtitle file in Z:\BeyondTV\AX\
main debug: `Z:\BeyondTV\AX\AX_1.mpg' successfully opened
ps debug: we found a length of: -1015267492
main debug: selecting program id=0
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "libmpeg2"
main debug: thread 4448 (decoder) created at priority 0 (input/decoder.c:159)
libmpeg2 debug: 720x480 (display 720,480), aspect 576000, sar 8:9, 29.971 fps
main debug: no usable vout present, spawning one
main debug: looking for sub filter module: 1 candidate
main debug: creating OSD menu object
main debug: opening osd definition file osdmenu/default.cfg
main debug: dir=osdmenu\default\
main debug: + action hotkey=key-play-pause (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\play_pause.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\play_pause.cue
access_file debug: opening file `osdmenu\default\selection\play_pause.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\play_pause.png
main debug: creating access '' path='osdmenu\default\selected\play_pause.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\play_pause.cue
access_file debug: opening file `osdmenu\default\selected\play_pause.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\play_pause.png
main debug: + action hotkey=key-stop (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\stop.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\stop.cue
access_file debug: opening file `osdmenu\default\selection\stop.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\stop.png
main debug: creating access '' path='osdmenu\default\selected\stop.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\stop.cue
access_file debug: opening file `osdmenu\default\selected\stop.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\stop.png
main debug: + action hotkey=key-chapter-prev (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: Registering subpicture channel, ID: 2
main debug: looking for decoder module: 27 candidates
main debug: looking for video filter2 module: 3 candidates
main debug: Registering subpicture channel, ID: 3
main debug: Registering subpicture channel, ID: 4
main debug: Registering subpicture channel, ID: 5
main debug: using decoder module "mpeg_audio"
main debug: thread 5104 (decoder) created at priority 2 (input/decoder.c:159)
mpeg_audio debug: MPGA channels:2 samplerate:48000 bitrate:256
main debug: looking for audio output module: 3 candidates
aout_directx debug: OpenAudio
aout_directx debug: found device: Primary Sound Driver
aout_directx debug: found device: NVIDIA(R) nForce(TM) Audio
aout_directx debug: device supports 2 channels
aout_directx debug: device supports 1 channel
aout_directx debug: creating DirectSoundThread
main debug: thread 5112 (DirectSound Notification Thread) created at priority 15 (directx.c:372)
aout_directx debug: DirectSoundThread ready
main debug: using audio output module "aout_directx"
main debug: output 's16l' 48000 Hz Stereo frame=1 samples/4 bytes
main debug: mixer 'fl32' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: filter(s) 'fl32'->'s16l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "float32tos16"
main debug: found a filter for the whole conversion
main debug: looking for audio mixer module: 3 candidates
main debug: using audio mixer module "float32_mixer"
main debug: input 'mpga' 48000 Hz Stereo frame=1152 samples/1161 bytes
main debug: filter(s) 'mpga'->'fl32' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "mpgatofixed32"
main debug: found a filter for the whole conversion
main debug: filter(s) 'fl32'->'fl32' 52800 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio filter module: 24 candidates
main debug: using audio filter module "bandlimited_resampler"
main debug: found a filter for the whole conversion
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\previous.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\previous.cue
access_file debug: opening file `osdmenu\default\selection\previous.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\previous.png
main debug: creating access '' path='osdmenu\default\selected\previous.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\previous.cue
access_file debug: opening file `osdmenu\default\selected\previous.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\previous.png
main debug: + action hotkey=key-jump-medium (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\bw.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\bw.cue
access_file debug: opening file `osdmenu\default\selection\bw.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\bw.png
main debug: creating access '' path='osdmenu\default\selected\bw.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\bw.cue
access_file debug: opening file `osdmenu\default\selected\bw.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
message warning: message queue overflowed
vcd debug: trying .cue file: osdmenu\default\selection\fw.cue
access_file debug: opening file `osdmenu\default\selection\fw.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\fw.png
main debug: creating access '' path='osdmenu\default\selected\fw.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\fw.cue
access_file debug: opening file `osdmenu\default\selected\fw.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\fw.png
main debug: + action hotkey=key-chapter-next (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\next.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\next.cue
access_file debug: opening file `osdmenu\default\selection\next.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\next.png
main debug: creating access '' path='osdmenu\default\selected\next.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\next.cue
access_file debug: opening file `osdmenu\default\selected\next.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\next.png
main debug: + action hotkey=key-quit (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\esc.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\esc.cue
access_file debug: opening file `osdmenu\default\selection\esc.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\esc.png
main debug: creating access '' path='osdmenu\default\selected\esc.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\esc.cue
access_file debug: opening file `osdmenu\default\selected\esc.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\esc.png
main debug: + action hotkey=key-vol-up (0,0)
main debug: creating access '' path='osdmenu\default\unselected.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\unselected.cue
access_file debug: opening file `osdmenu\default\unselected.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 760x40 RV24 -> 760x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=unselect, file=osdmenu\default\unselected.png
main debug: creating access '' path='osdmenu\default\selection\volume.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selection\volume.cue
access_file debug: opening file `osdmenu\default\selection\volume.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=select, file=osdmenu\default\selection\volume.png
main debug: creating access '' path='osdmenu\default\selected\volume.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\selected\volume.cue
access_file debug: opening file `osdmenu\default\selected\volume.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 480x40 RV24 -> 480x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- state=pressed, file=osdmenu\default\selected\volume.png
main debug: + (menu up) hotkey=key-vol-up (480,0)
main debug: + type=volume
main debug: + (menu up) hotkey down key-vol-down, file=osdmenu\default\selected\volume.png
main debug: creating access '' path='osdmenu\default\volume\volume_00.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\volume\volume_00.cue
access_file debug: opening file `osdmenu\default\volume\volume_00.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 280x40 RV24 -> 280x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- range=1, file=osdmenu\default\volume\volume_00.png
main debug: creating access '' path='osdmenu\default\volume\volume_01.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\volume\volume_01.cue
access_file debug: opening file `osdmenu\default\volume\volume_01.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 280x40 RV24 -> 280x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- range=2, file=osdmenu\default\volume\volume_01.png
main debug: creating access '' path='osdmenu\default\volume\volume_02.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\volume\volume_02.cue
access_file debug: opening file `osdmenu\default\volume\volume_02.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 280x40 RV24 -> 280x40 YUVA
ffmpeg debug: libavcodec already initialized
main debug: using video filter2 module "ffmpeg"
main debug: removing module "png"
main debug: removing module "ffmpeg"
main debug: |- range=3, file=osdmenu\default\volume\volume_02.png
main debug: creating access '' path='osdmenu\default\volume\volume_03.png'
main debug: looking for access2 module: 5 candidates
vcd debug: trying .cue file: osdmenu\default\volume\volume_03.cue
access_file debug: opening file `osdmenu\default\volume\volume_03.png'
main debug: using access2 module "access_file"
main debug: pre-buffering...
main debug: received first data for our buffer
main debug: removing module "access_file"
main debug: looking for decoder module: 27 candidates
main debug: using decoder module "png"
main debug: looking for video filter2 module: 3 candidates
ffmpeg debug: input: 280x40 RV24 -> 280x40 YUVA
message warning: message queue overflowed
vout_directx debug: screen dimensions (0x0,1152x864)
vout_directx debug: DirectDraw Capabilities: overlay=1 yuvoverlay=1 can_deinterlace_overlay=1 colorkey=1 stretch=1 bltfourcc=1
vout_directx debug: align_boundary_src=0,0 align_boundary_dest=1,1 align_size_src=0,0 align_size_dest=0,0
vout_directx debug: End DirectXInitDDraw
vout_directx debug: DirectXCreateDisplay
vout_directx debug: DirectXCreateClipper
vout_directx debug: disabling screen saver
main debug: using video output module "vout_directx"
vout_directx debug: NewPictureVec overlay:yes chroma:YV12
main debug: waiting for thread completion
vout_directx debug: YUV overlay created successfully
vout_directx debug: End NewPictureVec (succeeded)
main debug: got 1 direct buffer(s)
main debug: picture in 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: picture user 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: picture out 720x480 (0,0,720x480), chroma I420, ar 4:3, sar 8:9
main debug: direct render, mapping render pictures 0-6 to system pictures 1-7
main debug: thread 5100 (video output) created at priority 1 (video_output/video_output.c:421)
main warning: dts != current_pts (331984)
main warning: backward_pts != current_pts (-33367)
main warning: late picture skipped (43982)
main warning: late picture skipped (10729)