The VideoLAN Forums

Hi All:

I have a problem when I using vlc 2.04 in windows XP/7.
I want to keep the aspect ration for all videos in a playlist, but only the first video would be used the customized aspect ratio when I started the vlc player.
my step to reproduce is as following:
1,start vlc 2.04, open the preference settings and click all setting
2,in video interface, set aspect-ratio = 567:145, set crop=567:145
3,close the vlc 2.04 and restart again, open a playlist
4,the first video could be used this aspect-ratio, but all other videos would be used their default settings
5,I found the aspect-ratio and crop is always set to 567:145 in the menu->video
6,If I click the 567:145 in one of the aspect-ratio or crop menu, the playing video can be changed to 567:145 dynamical, but the next video would be changed to its default aspect-ratio again

How can I keep the customized aspect-ration all the time?

thanks very much

I downgrade the vlc to 1.1.9, some of videos in playlist are used the customized aspect-ratio, but the others are still used the default ratio.
at that time ,when I click the customized aspect-ratio in menu->video, these videos can be changed to customized ratio dynamical.

can everyone give me some suggestion? I want to use the customized aspect ratio for all video at all time, can one of vlc version do that?

thank you very much

can anyone give me some suggestions?

Please open Tools -> Messages (set Verbosity to 2) before you start the playback and then paste the full resulting log here or on Pastebin.com if it's too long.

This bug has already been reported, I think.

I have found so many peoples' found such solution in this forum for long time.

is it difficult to implement?

BTW, is there any method to change the aspect ration in a play list when video changing? I want to change aspect ration at every time when video changing?

I want to ask another question, when I set Aspect_ratio, I then try to get Aspect_ration when media changing, I found the getting Aspect_ratio is the same as I set before, but no effect.

is any method to refresh the aspect ration setting as the first time? I had set the aspect _ratio only when media changing, but no effect, version 1.19,2.03,2.04 are the same.

thanks very much.

It is a bug and hope somebody will fix it some day. Until then Lua script could help you to apply desired AR every time a next playlist item is played.
Scripting VLC in lua

the following is the log when use apsect_ratio to play two different videos in a playlist

the aspect_ratio has effect only at the first time with the first video.

please kindly give me some suggestions, thanks very much

######################################################################

static void Player::eventChangedCallBack(const libvlc_event_t*, void*)
void DataParser::sendLogInfo(QString, QString, QString) send log info
--------3---------------current-------ratio is :++++++++++++++++++++++++578:250
void ConnectClient::testContectState(QAbstractSocket::SocketState) QAbstractSocket::HostLookupState
--------3----------------------ratio is :++++++++++++++++++++++++ 578:250
void ConnectClient::testContectState(QAbstractSocket::SocketState) QAbstractSocket::ConnectingState
static void Player::eventChangedCallBack(const libvlc_event_t*, void*)
static void Player::eventChangedCallBack(const libvlc_event_t*, void*) unhandled event type!!
[1e5b0070] main libvlc debug: VLC media player - 2.0.1 Twoflower
[1e5b0070] main libvlc debug:
[1e5b0070] main libvlc debug: revision 2.0.1-0-gf432547
[1e5b0070] main libvlc debug: configured with ../extras/package/win32/../../../configure '--enable-update-check' '--enable-lua' '--enable-faad' '--enable-flac' '--enable-theora' '--enable-twolame' '--enable-quicktime' '--enable-avcodec' '--enable-merge-ffmpeg' '--enable-dca' '--enable-mpc' '--enable-libass' '--enable-x264' '--enable-schroedinger' '--enable-realrtsp' '--enable-live555' '--enable-dvdread' '--enable-shout' '--enable-goom' '--enable-caca' '--disable-portaudio' '--disable-sdl' '--enable-qt4' '--enable-skins2' '--enable-sse' '--enable-mmx' '--enable-libcddb' '--enable-zvbi' '--disable-telx' '--enable-sqlite' '--disable-dirac' '--host=i586-mingw32msvc' 'host_alias=i586-mingw32msvc'
[1e5b0070] main libvlc debug: searching plug-in modules
[1e5b0070] main libvlc debug: loading plugins cache file D:\case\easyway\source\2012-09-23\info-client\debug\plugins\plugins.dat
[1e5b0070] main libvlc debug: recursively browsing `D:\case\easyway\source\2012-09-23\info-client\debug\plugins'
[1e5b0070] main libvlc debug: saving plugins cache D:\case\easyway\source\2012-09-23\info-client\debug\plugins\plugins.dat
[1e5b0070] main libvlc debug: plug-ins loaded: 387 modules
[1e5b0070] main libvlc debug: translation test: code is "C"
[1e5b0070] main libvlc debug: CPU has capabilities MMX MMXEXT SSE SSE2 SSE3 SSSE3 SSE4.1 SSE4.2 FPU
[1e5b0070] main libvlc debug: looking for memcpy module: 4 candidates
[1e5b0070] main libvlc debug: using memcpy module "memcpymmxext"
[1e5b7f20] main interface debug: looking for interface module: 1 candidate
[1e5b7f20] main interface debug: using interface module "hotkeys"
[1e5b7f20] main interface debug: TIMER module_need() : 0.614 ms - Total 0.614 ms / 1 intvls (Avg 0.614 ms)
[1e64b0c8] main input debug: Creating an input for './video/K5-43.wmv'
[1e64b0c8] main input debug: using timeshift granularity of 50 MiB, in path 'C:\Users\eric\AppData\Local\Temp'
[1e64b0c8] main input debug: `file:///D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv' gives access `file' demux `' path `/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv'
[1e64b0c8] main input debug: creating demux: access='file' demux='' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv' file='D:\case\easyway\source\2012-09-23\info-client\.\video\K5-43.wmv'
[1e669040] main demux debug: looking for access_demux module: 3 candidates
[1e669040] main demux debug: no access_demux module matching "file" could be loaded
[1e669040] main demux debug: TIMER module_need() : 2.280 ms - Total 2.280 ms / 1 intvls (Avg 2.280 ms)
[1e64b0c8] main input debug: creating access 'file' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv', path='D:\case\easyway\source\2012-09-23\info-client\.\video\K5-43.wmv'
[1e676118] main access debug: looking for access module: 3 candidates
[1e676118] filesystem access debug: opening file `D:\case\easyway\source\2012-09-23\info-client\.\video\K5-43.wmv'
[1e676118] main access debug: using access module "filesystem"
[1e676118] main access debug: TIMER module_need() : 1.087 ms - Total 1.087 ms / 1 intvls (Avg 1.087 ms)
[1e5c2b00] main stream debug: Using stream method for AStream*
[1e5c2b00] main stream debug: starting pre-buffering
[1e5c2b00] main stream debug: received first data after 0 ms
[1e5c2b00] main stream debug: pre-buffering done 1024 bytes in 0s - 14925 KiB/s
[1e6561a8] main stream debug: looking for stream_filter module: 4 candidates
[1e6561a8] main stream debug: no stream_filter module matching "any" could be loaded
[1e6561a8] main stream debug: TIMER module_need() : 3.375 ms - Total 3.375 ms / 1 intvls (Avg 3.375 ms)
[1e6561a8] main stream debug: looking for stream_filter module: 1 candidate
[1e6561a8] main stream debug: using stream_filter module "stream_filter_record"
[1e6561a8] main stream debug: TIMER module_need() : 0.502 ms - Total 0.502 ms / 1 intvls (Avg 0.502 ms)
[1e64b0c8] main input debug: creating demux: access='file' demux='' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv' file='D:\case\easyway\source\2012-09-23\info-client\.\video\K5-43.wmv'
[1e669040] main demux debug: looking for demux module: 55 candidates
[1e6561a8] asf stream debug: found object guid: 0x75b22630-0x668e-0x11cf-0xa6d900aa0062ce6c size:5263
[1e6561a8] asf stream debug: read "header object" subobj:7, reserved1:1, reserved2:2
[1e6561a8] asf stream debug: found object guid: 0x8cabdca1-0xa947-0x11cf-0x8ee400c00c205365 size:104
[1e6561a8] asf stream debug: read "file properties object" file_id:0x10af281e-0x3e06-0x44fa-0xb8ddf01abf1a3060 file_size:28530055 creation_date:129648464423330000 data_packets_count:2393 play_duration:200450000 send_duration:190260000 preroll:5000 flags:2 min_data_packet_size:11920 max_data_packet_size:11920 max_bitrate:39993614
[1e6561a8] asf stream debug: found object guid: 0x5fbf03b5-0xa92e-0x11cf-0x8ee300c00c205365 size:4421
[1e6561a8] asf stream debug: read "header extension object" reserved1:0xabd3d211-0xa9ba-0x11cf-0x8ee600c00c205365 reserved2:6 header_extension_size:4375
[1e6561a8] asf stream debug: found object guid: 0x7c4346a9-0xefe0-0x4bfc-0xb229393ede415c85 size:39
[1e6561a8] asf stream debug: read "language list object" 1 entries
[1e6561a8] asf stream debug: - 'zh-cn'
[1e6561a8] asf stream debug: found object guid: 0x26f18b5d-0x4584-0x47ec-0x9f5f0e651f0452c9 size:26
[1e6561a8] asf stream warning: unknown asf object (not loaded)
[1e6561a8] asf stream debug: found object guid: 0xc5f8cbea-0x5baf-0x4877-0x8467aa8c44fa4cca size:218
[1e6561a8] asf stream debug: read "metadata object" 4 entries
[1e6561a8] asf stream debug: - IsVBR=0
[1e6561a8] asf stream debug: - DeviceConformanceTemplate=MP
[1e6561a8] asf stream debug: - IsVBR=0
[1e6561a8] asf stream debug: - DeviceConformanceTemplate=L3
[1e6561a8] asf stream debug: found object guid: 0x1806d474-0xcadf-0x4509-0xa4ba9aabcb96aae8 size:3856
[1e6561a8] asf stream warning: unknown asf object (not loaded)
[1e6561a8] asf stream debug: found object guid: 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:110
[1e6561a8] asf stream debug: read "extended stream properties object":
[1e6561a8] asf stream debug: - start=0 end=0
[1e6561a8] asf stream debug: - data bitrate=39540000 buffer=5000 initial fullness=0
[1e6561a8] asf stream debug: - alternate data bitrate=39540000 buffer=5000 initial fullness=0
[1e6561a8] asf stream debug: - maximum object size=140888
[1e6561a8] asf stream debug: - flags=0x2
[1e6561a8] asf stream debug: - stream number=1 language=0
[1e6561a8] asf stream debug: - average time per frame=400000
[1e6561a8] asf stream debug: - stream name count=0
[1e6561a8] asf stream debug: - payload extension system count=1
[1e6561a8] asf stream debug: found object guid: 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:88
[1e6561a8] asf stream debug: read "extended stream properties object":
[1e6561a8] asf stream debug: - start=0 end=0
[1e6561a8] asf stream debug: - data bitrate=256016 buffer=1579 initial fullness=0
[1e6561a8] asf stream debug: - alternate data bitrate=256016 buffer=1579 initial fullness=0
[1e6561a8] asf stream debug: - maximum object size=11889
[1e6561a8] asf stream debug: - flags=0x2
[1e6561a8] asf stream debug: - stream number=2 language=0
[1e6561a8] asf stream debug: - average time per frame=2230697
[1e6561a8] asf stream debug: - stream name count=0
[1e6561a8] asf stream debug: - payload extension system count=0
[1e6561a8] asf stream debug: found object guid: 0xd9aade20-0x7c17-0x4f9c-0xbc288555dd98e2a2 size:38
[1e6561a8] asf stream warning: unknown asf object (not loaded)
[1e6561a8] asf stream debug: found object guid: 0xd2d0a440-0xe307-0x11d2-0x97f000a0c95ea850 size:166
[1e6561a8] asf stream debug: read "extended content description object"
[1e6561a8] asf stream debug: - 'WMFSDKVersion' = '11.0.5721.5145'
[1e6561a8] asf stream debug: - 'WMFSDKNeeded' = '0.0.0.0000'
[1e6561a8] asf stream debug: - 'IsVBR' = 'false'
[1e6561a8] asf stream debug: found object guid: 0x86d15240-0x311d-0x11d0-0xa3a400a0c90348f6 size:256
[1e6561a8] asf stream debug: read "codec list object" reserved_guid:0x86d15241-0x311d-0x11d0-0xa3a400a0c90348f6 codec_entries_count:2
[1e6561a8] asf stream debug: - codec[0] video name:"Windows Media Video 9" description:"Professional" information_length:4
[1e6561a8] asf stream debug: - codec[1] audio name:"Windows Media Audio 9.2" description:"256 kbps, 44 kHz, stereo 1-pass CBR" information_length:2
[1e6561a8] asf stream debug: found object guid: 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:134
[1e6561a8] asf stream debug: read "stream Properties object" stream_type:0xbc19efc0-0x5b4d-0x11cf-0xa8fd00805f5c442b error_correction_type:0x20fb5700-0x5b55-0x11cf-0xa8fd00805f5c442b time_offset:0 type_specific_data_length:56 error_correction_data_length:0 flags:0x1 stream_number:1
[1e6561a8] asf stream debug: found object guid: 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:114
[1e6561a8] asf stream debug: read "stream Properties object" stream_type:0xf8699e40-0x5b4d-0x11cf-0xa8fd00805f5c442b error_correction_type:0xbfc3cd50-0x618f-0x11cf-0x8bb200aa00b4e220 time_offset:0 type_specific_data_length:28 error_correction_data_length:8 flags:0x2 stream_number:2
[1e6561a8] asf stream debug: found object guid: 0x7bf875ce-0x468d-0x11d1-0x8d82006097c9a2b2 size:38
[1e6561a8] asf stream debug: read "stream bitrate properties object"
[1e6561a8] asf stream debug: - stream=1 bitrate=39697129
[1e6561a8] asf stream debug: - stream=2 bitrate=296485
[1e6561a8] asf stream debug: found object guid: 0x75b22636-0x668e-0x11cf-0xa6d900aa0062ce6c size:28524610
[1e6561a8] asf stream debug: read "data object" file_id:0x10af281e-0x3e06-0x44fa-0xb8ddf01abf1a3060 total data packet:2393 reserved:257
[1e6561a8] asf stream debug: found object guid: 0x33000890-0xe5b1-0x11cf-0x89f400a0c90349cb size:182
[1e6561a8] asf stream debug: read "index object" file_id:0x10af281e-0x3e06-0x44fa-0xb8ddf01abf1a3060 index_entry_time_interval:10000000 max_packet_count:13 index_entry_count:21
[1e6561a8] asf stream debug: + 'Unknown' GUID 0x0-0x0-0x0-0x0000000000000000 size:0pos:0
[1e6561a8] asf stream debug: + 'Header' GUID 0x75b22630-0x668e-0x11cf-0xa6d900aa0062ce6c size:5263pos:0
[1e6561a8] asf stream debug: | + 'File Properties' GUID 0x8cabdca1-0xa947-0x11cf-0x8ee400c00c205365 size:104pos:30
[1e6561a8] asf stream debug: | + 'Header Extension' GUID 0x5fbf03b5-0xa92e-0x11cf-0x8ee300c00c205365 size:4421pos:134
[1e6561a8] asf stream debug: | | + 'Language List' GUID 0x7c4346a9-0xefe0-0x4bfc-0xb229393ede415c85 size:39pos:180
[1e6561a8] asf stream debug: | | + 'Unknown' GUID 0x26f18b5d-0x4584-0x47ec-0x9f5f0e651f0452c9 size:26pos:219
[1e6561a8] asf stream debug: | | + 'Metadata' GUID 0xc5f8cbea-0x5baf-0x4877-0x8467aa8c44fa4cca size:218pos:245
[1e6561a8] asf stream debug: | | + 'Padding' GUID 0x1806d474-0xcadf-0x4509-0xa4ba9aabcb96aae8 size:3856pos:463
[1e6561a8] asf stream debug: | | + 'Extended Stream Properties' GUID 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:110pos:4319
[1e6561a8] asf stream debug: | | + 'Extended Stream Properties' GUID 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:88pos:4429
[1e6561a8] asf stream debug: | | + 'Unknown' GUID 0xd9aade20-0x7c17-0x4f9c-0xbc288555dd98e2a2 size:38pos:4517
[1e6561a8] asf stream debug: | + 'Extended content description' GUID 0xd2d0a440-0xe307-0x11d2-0x97f000a0c95ea850 size:166pos:4555
[1e6561a8] asf stream debug: | + 'Codec List' GUID 0x86d15240-0x311d-0x11d0-0xa3a400a0c90348f6 size:256pos:4721
[1e6561a8] asf stream debug: | + 'Stream Properties' GUID 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:134pos:4977
[1e6561a8] asf stream debug: | + 'Stream Properties' GUID 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:114pos:5111
[1e6561a8] asf stream debug: | + 'Stream Bitrate Properties' GUID 0x7bf875ce-0x468d-0x11d1-0x8d82006097c9a2b2 size:38pos:5225
[1e6561a8] asf stream debug: + 'Data' GUID 0x75b22636-0x668e-0x11cf-0xa6d900aa0062ce6c size:28524610pos:5263
[1e6561a8] asf stream debug: + 'Simple Index' GUID 0x33000890-0xe5b1-0x11cf-0x89f400a0c90349cb size:182pos:28529873
[1e669040] asf demux debug: found 2 streams
[1e669040] asf demux debug: added new video stream(ID:1)
[1e64b0c8] main input debug: selecting program id=0
[1e669040] asf demux debug: added new audio stream(codec:0x161,ID:2)
[1e669040] main demux debug: using demux module "asf"
[1e669040] main demux debug: TIMER module_need() : 4.922 ms - Total 4.922 ms / 1 intvls (Avg 4.922 ms)
[1e64b0c8] main input debug: looking for a subtitle file in D:\case\easyway\source\2012-09-23\info-client\.\video
[1e5c0220] main decoder debug: looking for decoder module: 31 candidates
void DataParser::onFormatDataChanged(format) format change to: "525,54,1103,305"
ratio is ... "578:251"
[1e5c0220] avcodec decoder debug: libavcodec initialized (interface 0x360a64)
[1e5c0220] avcodec decoder debug: trying to use direct rendering
[1e5c0220] avcodec decoder debug: allowing 4 thread(s) for decoding
[wmv3 @ 1f8e2440] Extra data: 8 bits left, value: 0
[1e5c0220] avcodec decoder debug: ffmpeg codec (Windows Media Video 9) started
[1e5c0220] main decoder debug: using decoder module "avcodec"
[1e5c0220] main decoder debug: TIMER module_need() : 29.557 ms - Total 29.557 ms / 1 intvls (Avg 29.557 ms)
[1f8e2850] main decoder debug: looking for decoder module: 31 candidates
[1f8e2850] avcodec decoder debug: libavcodec already initialized
[1f8e2850] avcodec decoder debug: ffmpeg codec (Windows Media Audio 2) started
[1f8e2850] avcodec decoder debug: Using 192000 bytes output buffer
[1f8e2850] main decoder debug: using decoder module "avcodec"
[1f8e2850] main decoder debug: TIMER module_need() : 1.712 ms - Total 1.712 ms / 1 intvls (Avg 1.712 ms)
[1e611748] main demux meta debug: looking for meta reader module: 2 candidates
[1e611748] lua demux meta debug: Trying Lua scripts in C:\Users\eric\AppData\Roaming\vlc\lua\meta\reader
[1e611748] lua demux meta debug: Trying Lua scripts in D:\case\easyway\source\2012-09-23\info-client\debug\lua\meta\reader
[1e611748] main demux meta debug: no meta reader module matching "any" could be loaded
[1e611748] main demux meta debug: TIMER module_need() : 3.030 ms - Total 3.030 ms / 1 intvls (Avg 3.030 ms)
[1e64b0c8] main input debug: `file:///D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2FK5-43.wmv' successfully opened
[1e64b0c8] main input debug: Buffering 0%
[1e64b0c8] main input debug: Buffering 13%
[1e64b0c8] main input debug: Buffering 13%
[1e64b0c8] main input debug: Buffering 26%
[1e64b0c8] main input debug: Buffering 40%
[1e64b0c8] main input debug: Buffering 53%
[1e64b0c8] main input debug: Buffering 66%
[1e64b0c8] main input debug: Buffering 80%
[1e64b0c8] main input debug: Buffering 93%
[1e64b0c8] main input debug: Stream buffering done (320 ms in 2 ms)
[1f8f67b0] main spu text debug: looking for text renderer module: 2 candidates
[1f8f67b0] freetype spu text debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf
[1f8f67b0] freetype spu text debug: using fontsize: 2
[1f8f67b0] main spu text debug: using text renderer module "freetype"
[1f8f67b0] main spu text debug: TIMER module_need() : 1.998 ms - Total 1.998 ms / 1 intvls (Avg 1.998 ms)
[1f93a408] main scale debug: looking for video filter2 module: 18 candidates
[1f93a408] swscale scale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality)
[1f93a408] main scale debug: using video filter2 module "swscale"
[1f93a408] main scale debug: TIMER module_need() : 1.743 ms - Total 1.743 ms / 1 intvls (Avg 1.743 ms)
[1fa72b18] main scale debug: looking for video filter2 module: 18 candidates
[1fa72b18] yuvp scale debug: YUVP to YUVA converter
[1fa72b18] main scale debug: using video filter2 module "yuvp"
[1fa72b18] main scale debug: TIMER module_need() : 4.209 ms - Total 4.209 ms / 1 intvls (Avg 4.209 ms)
[1f92e050] main video output debug: Deinterlacing available
[1f92e050] main video output debug: deinterlace 0, mode blend, is_needed 0
[1f92e050] main video output debug: Opening vout display wrapper
[1f8f3140] main vout display debug: looking for vout display module: 6 candidates
[1f8f3140] direct3d vout display debug: creating Vout EventThread
[1f8f3140] direct3d vout display debug: DirectXCreateWindow
[1e611748] main window debug: looking for vout window hwnd module: 2 candidates
[1e611748] main window debug: using vout window hwnd module "drawable"
[1e611748] main window debug: TIMER module_need() : 0.634 ms - Total 0.634 ms / 1 intvls (Avg 0.634 ms)
[1f8f3140] direct3d vout display debug: created video sub-window
[1f8f3140] direct3d vout display debug: Vout EventThread running
[1f8f3140] direct3d vout display debug: disabling screen saver
[1f8f3140] main vout display debug: VoutDisplayEvent 'resize' 736x614 window
[1f8f3140] direct3d vout display warning: trying surface pixel format: YV12
[1f8f3140] direct3d vout display debug: selected surface pixel format is YV12
[1f8f3140] direct3d vout display debug: Using D3DTEXF_LINEAR for minification
[1f8f3140] direct3d vout display debug: Using D3DTEXF_LINEAR for magnification
[1f8f3140] direct3d vout display debug: Direct3D scene created successfully
[1f8f3140] direct3d vout display debug: Direct3D device adapter successfully initialized
[1f8f3140] main vout display debug: using vout display module "direct3d"
[1f8f3140] main vout display debug: TIMER module_need() : 45.184 ms - Total 45.184 ms / 1 intvls (Avg 45.184 ms)
[1f92e050] main video output debug: original format sz 720x576, of (0,0), vsz 720x576, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
[1f8f67b0] main spu text debug: removing module "freetype"
[1f8ecfc8] main spu text debug: looking for text renderer module: 2 candidates
[1f8f3140] main vout display debug: VoutDisplayEvent 'resize' 578x251 window
[1f8ecfc8] freetype spu text debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf
[1f8ecfc8] freetype spu text debug: using fontsize: 2
[1f8ecfc8] main spu text debug: using text renderer module "freetype"
[1f8ecfc8] main spu text debug: TIMER module_need() : 1.001 ms - Total 1.001 ms / 1 intvls (Avg 1.001 ms)
[1e5c0220] avcodec decoder debug: using direct rendering
[1f8f3140] main vout display error: Failed to set on top
[1e5c0220] main decoder debug: End of video preroll
[1e5c0220] main decoder debug: Received first picture
[1f92e050] main video output debug: Post-processing available
[1e64b0c8] main input debug: Decoder buffering done in 167 ms
[1f8f3140] main vout display debug: auto hiding mouse cursor
[1e64b0c8] main input error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 300 ms)
[1e64b0c8] main input error: ES_OUT_RESET_PCR called
[1f8e2850] avcodec decoder warning: Physical channel configuration not set : guessing
[1e676040] main generic debug: creating audio output
[219e7e18] main audio output debug: looking for audio output module: 2 candidates
[219e7e18] aout_directx audio output debug: Opening DirectSound Audio Output
[219e7e18] aout_directx audio output debug: found device: 主声音驱动程序
[219e7e18] aout_directx audio output debug: found device: 扬声器 (Realtek High Definition Audio)
[219e7e18] aout_directx audio output debug: using device: 扬声器 (Realtek High Definition Audio)
[219e7e18] aout_directx audio output debug: device supports 2 channels (DEFAULT!)
[219e7e18] aout_directx audio output debug: device supports 1 channel
[219e7e18] aout_directx audio output debug: Windows says your SpeakerConfig is stereo
[219e7e18] aout_directx audio output debug: creating DirectSoundThread
[219e7e18] aout_directx audio output debug: DirectSoundThread ready
[219e7e18] main audio output debug: using audio output module "aout_directx"
[219e7e18] main audio output debug: TIMER module_need() : 32.820 ms - Total 32.820 ms / 1 intvls (Avg 32.820 ms)
[219e7e18] main audio output debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes
[219e7e18] main audio output debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes
[219e7e18] main audio output debug: filter(s) 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo
[1f8ed2f0] main audio filter debug: looking for audio filter module: 14 candidates
[1f8ed2f0] audio_format audio filter debug: f32l->s16l, bits per sample: 32->16
[1f8ed2f0] main audio filter debug: using audio filter module "audio_format"
[1f8ed2f0] main audio filter debug: TIMER module_need() : 4.820 ms - Total 4.820 ms / 1 intvls (Avg 4.820 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[1e5fc718] main mixer debug: looking for audio mixer module: 2 candidates
[1e5fc718] main mixer debug: using audio mixer module "float32_mixer"
[1e5fc718] main mixer debug: TIMER module_need() : 0.565 ms - Total 0.565 ms / 1 intvls (Avg 0.565 ms)
[219e7e18] main audio output debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes
[1f8ed618] main audio filter debug: looking for audio filter module: 1 candidate
[1f8ed618] scaletempo audio filter debug: format: 44100 rate, 2 nch, 4 bps, fl32
[1f8ed618] scaletempo audio filter debug: params: 30 stride, 0.200 overlap, 14 search
[1f8ed618] scaletempo audio filter debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode
[1f8ed618] main audio filter debug: using audio filter module "scaletempo"
[1f8ed618] main audio filter debug: TIMER module_need() : 0.643 ms - Total 0.643 ms / 1 intvls (Avg 0.643 ms)
[219e7e18] main audio output debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
[1f8ed940] main audio filter debug: looking for audio filter module: 14 candidates
[1f8ed940] audio_format audio filter debug: s16l->f32l, bits per sample: 16->32
[1f8ed940] main audio filter debug: using audio filter module "audio_format"
[1f8ed940] main audio filter debug: TIMER module_need() : 0.208 ms - Total 0.208 ms / 1 intvls (Avg 0.208 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[219e7e18] main audio output debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
[219e7e18] main audio output debug: conversion pipeline completed
[219e7e18] main audio output debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo
[1f8edc68] main audio filter debug: looking for audio filter module: 14 candidates
[1f8edc68] main audio filter debug: using audio filter module "samplerate"
[1f8edc68] main audio filter debug: TIMER module_need() : 0.185 ms - Total 0.185 ms / 1 intvls (Avg 0.185 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[1f8e2850] main decoder debug: End of audio preroll
[1f8e2850] main decoder warning: received buffer in the future
[1f8e2850] main decoder warning: received buffer in the future
[1f8e2850] main decoder warning: received buffer in the future
[1e64b0c8] main input debug: Buffering 0%
[1f8e2850] main decoder debug: End of audio preroll
[1e64b0c8] main input debug: Stream buffering done (371 ms in 1 ms)
[1e5c0220] main decoder debug: End of video preroll
[1e5c0220] main decoder debug: Received first picture
[1e64b0c8] main input debug: Decoder buffering done in 39 ms
[219e7e18] main audio output warning: buffer too early (-46375), down-sampling
[219e7e18] main audio output warning: audio output out of sync, adjusting dates (77203 us)
[219e7e18] main audio output warning: not synchronized (77205 us), resampling
virtual void HeartBeatThread::run()
[219e7e18] main audio output warning: resampling stopped after 1577306 usec (drift: -31434)
[1e669040] asf demux warning: cannot peek while getting new packet, EOF ?
[1e64b0c8] main input debug: EOF reached
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e64b0c8] main input debug: waiting decoder fifos to empty
[1e5c0220] main decoder debug: removing module "avcodec"
[1e5c0220] avcodec decoder debug: ffmpeg codec (Windows Media Video 9) stopped
[1e5c0220] main decoder debug: killing decoder fourcc `WMV3', 0 PES in FIFO
[1e676040] main generic debug: saving a free vout
[1e676040] main generic debug: reusing provided vout
[1f8e2850] main decoder debug: removing module "avcodec"
[1f8e2850] avcodec decoder debug: ffmpeg codec (Windows Media Audio 2) stopped
[1f8e2850] main decoder debug: killing decoder fourcc `WMA2', 0 PES in FIFO
[1f8ed940] main audio filter debug: removing module "audio_format"
[1f8ed618] main audio filter debug: removing module "scaletempo"
[1f8edc68] main audio filter debug: removing module "samplerate"
[219e7e18] main audio output debug: removing module "aout_directx"
[219e7e18] aout_directx audio output debug: closing audio device
[219e7e18] aout_directx audio output debug: DirectSoundThread exiting
static void Player::eventChangedCallBack(const libvlc_event_t*, void*)
--------3---------------current-------ratio is :++++++++++++++++++++++++ 578:250
void DataParser::sendLogInfo(QString, QString, QString) send log info
--------3----------------------ratio is :++++++++++++++++++++++++ 578:250
static void Player::eventChangedCallBack(const libvlc_event_t*, void*)
static void Player::eventChangedCallBack(const libvlc_event_t*, void*) unhandled event type!!
[1f8ed2f0] main audio filter debug: removing module "audio_format"
[1e5fc718] main mixer debug: removing module "float32_mixer"
[1e676040] main generic debug: releasing audio output
[1e669040] main demux debug: removing module "asf"
[1e6561a8] asf stream debug: free asf object 0x8cabdca1-0xa947-0x11cf-0x8ee400c00c205365
[1e6561a8] asf stream debug: free asf object 0x7c4346a9-0xefe0-0x4bfc-0xb229393ede415c85
[1e6561a8] asf stream warning: unknown asf object 0x26f18b5d-0x4584-0x47ec-0x9f5f0e651f0452c9
[1e6561a8] asf stream debug: free asf object 0xc5f8cbea-0x5baf-0x4877-0x8467aa8c44fa4cca
[1e6561a8] asf stream warning: unknown asf object 0x1806d474-0xcadf-0x4509-0xa4ba9aabcb96aae8
[1e6561a8] asf stream debug: free asf object 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a
[1e6561a8] asf stream debug: free asf object 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a
[1e6561a8] asf stream warning: unknown asf object 0xd9aade20-0x7c17-0x4f9c-0xbc288555dd98e2a2
[1e6561a8] asf stream debug: free asf object 0x5fbf03b5-0xa92e-0x11cf-0x8ee300c00c205365
[1e6561a8] asf stream debug: free asf object 0xd2d0a440-0xe307-0x11d2-0x97f000a0c95ea850
[1e6561a8] asf stream debug: free asf object 0x86d15240-0x311d-0x11d0-0xa3a400a0c90348f6
[1e6561a8] asf stream debug: free asf object 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365
[1e6561a8] asf stream debug: free asf object 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365
[1e6561a8] asf stream debug: free asf object 0x7bf875ce-0x468d-0x11d1-0x8d82006097c9a2b2
[1e6561a8] asf stream debug: free asf object 0x75b22630-0x668e-0x11cf-0xa6d900aa0062ce6c
[1e6561a8] asf stream debug: free asf object 0x75b22636-0x668e-0x11cf-0xa6d900aa0062ce6c
[1e6561a8] asf stream debug: free asf object 0x33000890-0xe5b1-0x11cf-0x89f400a0c90349cb
[1e64b0c8] main input debug: Program doesn't contain anymore ES
[1e6561a8] main stream debug: removing module "stream_filter_record"
[1e676118] main access debug: removing module "filesystem"
[1e64b0c8] main input debug: TIMER input launching for './video/K5-43.wmv' : 49.535 ms - Total 49.535 ms / 1 intvls (Avg 49.535 ms)
[1e64b0c8] main input debug: Creating an input for './video/好莱客.avi'
[1e64b0c8] main input debug: using timeshift granularity of 50 MiB, in path 'C:\Users\eric\AppData\Local\Temp'
[1e64b0c8] main input debug: `file:///D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi' gives access `file' demux `' path `/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi'
[1e64b0c8] main input debug: creating demux: access='file' demux='' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi' file='D:\case\easyway\source\2012-09-23\info-client\.\video\好莱客.avi'
[1e669320] main demux debug: looking for access_demux module: 3 candidates
[1e669320] main demux debug: no access_demux module matching "file" could be loaded
[1e669320] main demux debug: TIMER module_need() : 1.059 ms - Total 1.059 ms / 1 intvls (Avg 1.059 ms)
[1e64b0c8] main input debug: creating access 'file' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi', path='D:\case\easyway\source\2012-09-23\info-client\.\video\好莱客.avi'
[1e676118] main access debug: looking for access module: 3 candidates
[1e676118] filesystem access debug: opening file `D:\case\easyway\source\2012-09-23\info-client\.\video\好莱客.avi'
[1e676118] main access debug: using access module "filesystem"
[1e676118] main access debug: TIMER module_need() : 0.800 ms - Total 0.800 ms / 1 intvls (Avg 0.800 ms)
[1fa70ab0] main stream debug: Using stream method for AStream*
[1fa70ab0] main stream debug: starting pre-buffering
[1fa70ab0] main stream debug: received first data after 0 ms
[1fa70ab0] main stream debug: pre-buffering done 1024 bytes in 0s - 10989 KiB/s
[1fa70c10] main stream debug: looking for stream_filter module: 4 candidates
[1fa70c10] main stream debug: no stream_filter module matching "any" could be loaded
[1fa70c10] main stream debug: TIMER module_need() : 0.237 ms - Total 0.237 ms / 1 intvls (Avg 0.237 ms)
[1fa70c10] main stream debug: looking for stream_filter module: 1 candidate
[1fa70c10] main stream debug: using stream_filter module "stream_filter_record"
[1fa70c10] main stream debug: TIMER module_need() : 0.192 ms - Total 0.192 ms / 1 intvls (Avg 0.192 ms)
[1e64b0c8] main input debug: creating demux: access='file' demux='' location='/D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi' file='D:\case\easyway\source\2012-09-23\info-client\.\video\好莱客.avi'
[1e6693d8] main demux debug: looking for demux module: 55 candidates
[1fa70c10] avi stream debug: <list 'AVI '>
[1fa70c10] avi stream debug: <list 'hdrl'>
[1fa70c10] avi stream debug: <list 'strl'>
[1fa70c10] avi stream warning: unknown chunk (not loaded)
[1fa70c10] avi stream debug: </list 'strl'>
[1fa70c10] avi stream debug: <list 'strl'>
[1fa70c10] avi stream debug: </list 'strl'>
[1fa70c10] avi stream debug: </list 'hdrl'>
[1fa70c10] avi stream debug: <list 'INFO'>
[1fa70c10] avi stream debug: </list 'INFO'>
[1fa70c10] avi stream debug: skipping movi chunk
[1fa70c10] avi stream debug: </list 'AVI '>
[1fa70c10] avi stream debug: <list 'AVI '>
[1fa70c10] avi stream debug: <list 'hdrl'>
[1fa70c10] avi stream debug: <list 'strl'>
[1fa70c10] avi stream warning: unknown chunk (not loaded)
[1fa70c10] avi stream debug: </list 'strl'>
[1fa70c10] avi stream debug: <list 'strl'>
[1fa70c10] avi stream debug: </list 'strl'>
[1fa70c10] avi stream debug: </list 'hdrl'>
[1fa70c10] avi stream debug: <list 'INFO'>
[1fa70c10] avi stream debug: </list 'INFO'>
[1fa70c10] avi stream debug: skipping movi chunk
[1fa70c10] avi stream debug: </list 'AVI '>
[1fa70c10] avi stream debug: * LIST-root size:9161194 pos:0
[1fa70c10] avi stream debug: + RIFF-AVI size:4966882 pos:0
[1fa70c10] avi stream debug: | + LIST-hdrl size:8898 pos:12
[1fa70c10] avi stream debug: | | + avih size:56 pos:24
[1fa70c10] avi stream debug: | | + LIST-strl size:4316 pos:88
[1fa70c10] avi stream debug: | | | + strh size:56 pos:100
[1fa70c10] avi stream debug: | | | + strf size:40 pos:164
[1fa70c10] avi stream debug: | | | + JUNK size:4116 pos:212
[1fa70c10] avi stream debug: | | | + vprp size:68 pos:4336
[1fa70c10] avi stream debug: | | + LIST-strl size:4230 pos:4412
[1fa70c10] avi stream debug: | | | + strh size:56 pos:4424
[1fa70c10] avi stream debug: | | | + strf size:30 pos:4488
[1fa70c10] avi stream debug: | | | + JUNK size:4116 pos:4526
[1fa70c10] avi stream debug: | | + JUNK size:260 pos:8650
[1fa70c10] avi stream debug: | + LIST-INFO size:26 pos:8918
[1fa70c10] avi stream debug: | | + ISFT size:13 pos:8930
[1fa70c10] avi stream debug: | + JUNK size:1016 pos:8952
[1fa70c10] avi stream debug: | + LIST-movi size:4941746 pos:9976
[1fa70c10] avi stream debug: | + idx1 size:15152 pos:4951730
[1fa70c10] avi stream debug: + RIFF-AVI size:4966882 pos:4966890
[1fa70c10] avi stream debug: | + LIST-hdrl size:8898 pos:4966902
[1fa70c10] avi stream debug: | | + avih size:56 pos:4966914
[1fa70c10] avi stream debug: | | + LIST-strl size:4316 pos:4966978
[1fa70c10] avi stream debug: | | | + strh size:56 pos:4966990
[1fa70c10] avi stream debug: | | | + strf size:40 pos:4967054
[1fa70c10] avi stream debug: | | | + JUNK size:4116 pos:4967102
[1fa70c10] avi stream debug: | | | + vprp size:68 pos:4971226
[1fa70c10] avi stream debug: | | + LIST-strl size:4230 pos:4971302
[1fa70c10] avi stream debug: | | | + strh size:56 pos:4971314
[1fa70c10] avi stream debug: | | | + strf size:30 pos:4971378
[1fa70c10] avi stream debug: | | | + JUNK size:4116 pos:4971416
[1fa70c10] avi stream debug: | | + JUNK size:260 pos:4975540
[1fa70c10] avi stream debug: | + LIST-INFO size:26 pos:4975808
[1fa70c10] avi stream debug: | | + ISFT size:13 pos:4975820
[1fa70c10] avi stream debug: | + JUNK size:1016 pos:4975842
[1fa70c10] avi stream debug: | + LIST-movi size:4941746 pos:4976866
[1e6693d8] avi demux warning: multiple riff -> OpenDML ?
[1e6693d8] avi demux debug: AVIH: 2 stream, flags HAS_INDEX IS_INTERLEAVED TRUST_CKTYPE
[1e6693d8] avi demux debug: stream[0] rate:25 scale:1 samplesize:0
[1e6693d8] avi demux debug: stream[0] video(DX50) 720x576 24bpp 25.000000fps
[1e64b0c8] main input debug: selecting program id=0
[1e6693d8] avi demux debug: stream[1] rate:1225 scale:32 samplesize:0
[1e6693d8] avi demux debug: stream[1] audio(0x55 - MPEG Audio layer 1/2/3) 2 channels 44100Hz 0bits
[1e6693d8] avi demux debug: selected standard index for stream[0]
[1e6693d8] avi demux debug: selected standard index for stream[1]
[1e6693d8] avi demux debug: stream[0] created 374 index entries
[1e6693d8] avi demux debug: stream[1] created 573 index entries
[1e6693d8] avi demux debug: stream[0] length:14 (based on index)
[1e6693d8] avi demux debug: stream[1] length:14 (based on index)
[1e6693d8] main demux debug: using demux module "avi"
[1e6693d8] main demux debug: TIMER module_need() : 6.347 ms - Total 6.347 ms / 1 intvls (Avg 6.347 ms)
[1e64b0c8] main input debug: looking for a subtitle file in D:\case\easyway\source\2012-09-23\info-client\.\video
[27d38bf0] main decoder debug: looking for decoder module: 31 candidates
[27d38bf0] avcodec decoder debug: libavcodec already initialized
[27d38bf0] avcodec decoder debug: trying to use direct rendering
[27d38bf0] avcodec decoder debug: allowing 4 thread(s) for decoding
[27d38bf0] avcodec decoder debug: ffmpeg codec (MPEG-4 Video) started
[27d38bf0] avcodec decoder debug: using frame thread mode with 4 threads
[27d38bf0] main decoder debug: using decoder module "avcodec"
[27d38bf0] main decoder debug: TIMER module_need() : 4.239 ms - Total 4.239 ms / 1 intvls (Avg 4.239 ms)
[2794eb68] main decoder debug: looking for decoder module: 31 candidates
[2794eb68] main decoder debug: using decoder module "mpeg_audio"
[2794eb68] main decoder debug: TIMER module_need() : 0.432 ms - Total 0.432 ms / 1 intvls (Avg 0.432 ms)
[1e611910] main demux meta debug: looking for meta reader module: 2 candidates
[1e611910] lua demux meta debug: Trying Lua scripts in C:\Users\eric\AppData\Roaming\vlc\lua\meta\reader
[1e611910] lua demux meta debug: Trying Lua scripts in D:\case\easyway\source\2012-09-23\info-client\debug\lua\meta\reader
[1e611910] main demux meta debug: no meta reader module matching "any" could be loaded
[1e611910] main demux meta debug: TIMER module_need() : 1.192 ms - Total 1.192 ms / 1 intvls (Avg 1.192 ms)
[1e64b0c8] main input debug: `file:///D:/case/easyway/source/2012-09-23/info-client/.%2Fvideo%2F%E5%A5%BD%E8%8E%B1%E5%AE%A2.avi' successfully opened
[1e64b0c8] main input debug: Buffering 0%
[1e64b0c8] main input debug: Buffering 8%
[1e64b0c8] main input debug: Buffering 16%
[1e64b0c8] main input debug: Buffering 25%
[1e64b0c8] main input debug: Buffering 33%
[1e64b0c8] main input debug: Buffering 41%
[1e64b0c8] main input debug: Buffering 50%
[1e676040] main generic debug: [1e64b0c8] trying to reuse free vout
main input debug: [1f8ecfc8] Buffering 58%
main spu text debug: removing module "freetype"
[1e64b0c8] main input debug: Buffering 66%
[1e64b0c8] main input debug: Buffering 75%
[1e64b0c8] main input debug: Buffering 83%
[1f8ecfc8] [1e64b0c8] main spu text debug: main input debug: looking for text renderer module: 2 candidates
Buffering 91%
[1e64b0c8] main input debug: Buffering 100%
[1e64b0c8] main input debug: Stream buffering done (325 ms in 1 ms)
[2794eb68] mpeg_audio decoder debug: MPGA channels:2 samplerate:44100 bitrate:320
[1f8ecfc8] freetype spu text debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf
[1f8ecfc8] freetype spu text debug: using fontsize: 2
[1f8ecfc8] main spu text debug: using text renderer module "freetype"
[1f8ecfc8] main spu text debug: TIMER module_need() : 1.365 ms - Total 1.365 ms / 1 intvls (Avg 1.365 ms)
[1e676040] main generic debug: reusing provided vout
[27d38bf0] [1e676040] avcodec decoder debug: main generic debug: using direct rendering
recycling audio output
[219e7e18] main audio output debug: looking for audio output module: 2 candidates
[219e7e18] aout_directx audio output debug: Opening DirectSound Audio Output
[219e7e18] aout_directx audio output debug: found device: 主声音驱动程序
[219e7e18] aout_directx audio output debug: found device: 扬声器 (Realtek High Definition Audio)
[219e7e18] aout_directx audio output debug: using device: 扬声器 (Realtek High Definition Audio)
[27d38bf0] main decoder debug: End of video preroll
[27d38bf0] main decoder debug: Received first picture
[219e7e18] aout_directx audio output debug: device supports 2 channels (DEFAULT!)
[219e7e18] aout_directx audio output debug: device supports 1 channel
[219e7e18] aout_directx audio output debug: Windows says your SpeakerConfig is stereo
[219e7e18] aout_directx audio output debug: creating DirectSoundThread
[219e7e18] main audio output debug: using audio output module "aout_directx"
[219e7e18] main audio output debug: TIMER module_need() : 31.392 ms - Total 31.392 ms / 1 intvls (Avg 31.392 ms)
[219e7e18] aout_directx audio output debug: DirectSoundThread ready
[219e7e18] main audio output debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes
[219e7e18] main audio output debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes
[219e7e18] main audio output debug: filter(s) 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo
[1f8ed2f0] main audio filter debug: looking for audio filter module: 14 candidates
[1f8ed2f0] audio_format audio filter debug: f32l->s16l, bits per sample: 32->16
[1f8ed2f0] main audio filter debug: using audio filter module "audio_format"
[1f8ed2f0] main audio filter debug: TIMER module_need() : 0.224 ms - Total 0.224 ms / 1 intvls (Avg 0.224 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[1e5fc688] main mixer debug: looking for audio mixer module: 2 candidates
[1e5fc688] main mixer debug: using audio mixer module "float32_mixer"
[1e5fc688] main mixer debug: TIMER module_need() : 0.141 ms - Total 0.141 ms / 1 intvls (Avg 0.141 ms)
[219e7e18] main audio output debug: input 'mpga' 44100 Hz Stereo frame=1152 samples/1053 bytes
[1f8ed618] main audio filter debug: looking for audio filter module: 1 candidate
[1f8ed618] scaletempo audio filter debug: format: 44100 rate, 2 nch, 4 bps, fl32
[1f8ed618] scaletempo audio filter debug: params: 30 stride, 0.200 overlap, 14 search
[1f8ed618] scaletempo audio filter debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode
[1f8ed618] main audio filter debug: using audio filter module "scaletempo"
[1f8ed618] main audio filter debug: TIMER module_need() : 0.275 ms - Total 0.275 ms / 1 intvls (Avg 0.275 ms)
[219e7e18] main audio output debug: filter(s) 'mpga'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
[1f8ed940] main audio filter debug: looking for audio filter module: 14 candidates
[1f8ed940] mpgatofixed32 audio filter debug: mpga->f32l, bits per sample: 32
[1f8ed940] main audio filter debug: using audio filter module "mpgatofixed32"
[1f8ed940] main audio filter debug: TIMER module_need() : 0.194 ms - Total 0.194 ms / 1 intvls (Avg 0.194 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[219e7e18] main audio output debug: filter(s) 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
[219e7e18] main audio output debug: conversion pipeline completed
[219e7e18] main audio output debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo
[1f8edc68] main audio filter debug: looking for audio filter module: 14 candidates
[1f8edc68] main audio filter debug: using audio filter module "samplerate"
[1f8edc68] main audio filter debug: TIMER module_need() : 0.214 ms - Total 0.214 ms / 1 intvls (Avg 0.214 ms)
[219e7e18] main audio output debug: conversion pipeline completed
[2794eb68] main decoder debug: End of audio preroll
[1e64b0c8] main input debug: Decoder buffering done in 34 ms
[219e7e18] main audio output warning: PTS is out of range (-9973), dropping buffer
[219e7e18] main audio output warning: PTS is out of range (-36003), dropping buffer
[1f8ed940] mpgatofixed32 audio filter debug: libmad error: bad main_data_begin pointer
[219e7e18] main audio output warning: audio output out of sync, adjusting dates (66524 us)
[219e7e18] main audio output warning: not synchronized (66527 us), resampling
[219e7e18] main audio output warning: buffer too late (66072), up-sampling
[1f8f3140] main vout display debug: VoutDisplayEvent 'mouse button' 0 t=8
[1f8f3140] main vout display debug: VoutDisplayEvent 'mouse button' 0 t=9
[1f8f3140] direct3d vout display debug: WinProc WM_DESTROY
[1f8f3140] direct3d vout display debug: DirectXEventThread terminating
[1f8f3140] direct3d vout display debug: DirectXCloseWindow
[1f8f3140] direct3d vout display debug: WinProc WM_DESTROY