Page 1 of 1

(VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 17 Dec 2011 18:47
by quality
Greetings

I've noticed this problem when playing WMV files
It plays for 1 sec, then video pauses for about 1-1.5 sec (audio continues normally though), and afterwards it continues play ok.
So far, I've tried files being:

Code: Select all

Codec: Windows Media Audio 2 (WMA2) Codec: Windows Media Video 7 (WMV1)
or

Code: Select all

Codec: Windows Media Audio 2 (WMA2) Codec: Windows Media Video 9 (WMV3)
This happens every single file I try to play a WMV file.

I've tried these files in Windows Media Player or Media Player Classic (with latest ffdshow)
and they are played without this issue.
I've also uninstalled+reinstalled VLC but didn't help.

I don't have any problem with other filetypes.

Thank you

PS. I use win7 64bit

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 17 Dec 2011 21:18
by VLC_help
Tools -> Messages (set Verbosity to 2)

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 18 Dec 2011 01:56
by Jean-Baptiste Kempf
And please share the files.

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 18 Dec 2011 20:28
by quality
A video: http://www.mediafire.com/?45ldxbtzac5wvdd
Log:

Code: Select all

main debug: adding item `Children - Funny videos.wmv' ( file:///C:/Users/Kostas/Desktop/Children%20-%20Funny%20videos.wmv ) main debug: rebuilding array of current - root Playlist main debug: rebuild done - 2 items, index 0 main debug: processing request item Children - Funny videos.wmv node Playlist skip 0 main debug: resyncing on Children - Funny videos.wmv main debug: Children - Funny videos.wmv is at 1 main debug: starting new item main debug: creating new input thread main debug: Creating an input for 'Children - Funny videos.wmv' qt4 debug: Adding a new MRL to recent ones: C:\Users\Kostas\Desktop\Children - Funny videos.wmv main debug: Creating an input for 'Children - Funny videos.wmv' main debug: meta ok for (null), need to fetch art main debug: looking for meta fetcher module: 1 candidate lua debug: Trying Lua scripts in C:\Users\Kostas\AppData\Roaming\vlc\lua\meta\fetcher main debug: thread started main debug: thread (input) created at priority 1 (../.././src/input/input.c:220) main debug: using timeshift granularity of 50 MiB main debug: using timeshift path 'C:\Users\Kostas\AppData\Local\Temp' lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher main debug: `file:///C:/Users/Kostas/Desktop/Children%20-%20Funny%20videos.wmv' gives access `file' demux `' path `C:\Users\Kostas\Desktop\Children - Funny videos.wmv' main debug: creating demux: access='file' demux='' path='C:\Users\Kostas\Desktop\Children - Funny videos.wmv' lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\fetcher\tvrage.lua main debug: looking for access_demux module: 2 candidates main debug: no access_demux module matching "file" could be loaded main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: creating access 'file' path='C:\Users\Kostas\Desktop\Children - Funny videos.wmv' main debug: looking for access module: 2 candidates filesystem debug: opening file `C:\Users\Kostas\Desktop\Children - Funny videos.wmv' main debug: using access module "filesystem" main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: Using AStream*Stream main debug: pre buffering main debug: received first data after 0 ms main debug: pre-buffering done 1024 bytes in 0s - 1000000 KiB/s main debug: looking for stream_filter module: 2 candidates main debug: no stream_filter module matching "any" could be loaded main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: using meta fetcher module "lua" main debug: TIMER module_need() : 5.000 ms - Total 5.000 ms / 1 intvls (Avg 5.000 ms) main debug: removing module "lua" main debug: searching art for Children - Funny videos.wmv main debug: looking for stream_filter module: 1 candidate main debug: using stream_filter module "stream_filter_record" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: creating demux: access='file' demux='' path='C:\Users\Kostas\Desktop\Children - Funny videos.wmv' main debug: looking for art finder module: 2 candidates main debug: looking for demux module: 52 candidates asf debug: found object guid: 0x75b22630-0x668e-0x11cf-0xa6d900aa0062ce6c size:5442 asf debug: read "header object" subobj:8, reserved1:1, reserved2:2 asf debug: found object guid: 0xd2d0a440-0xe307-0x11d2-0x97f000a0c95ea850 size:300 asf debug: read "extended content description object" asf debug: - 'Application' = 'Windows Movie Maker 2.1.4026.0' asf debug: - 'WM/ParentalRating' = '' asf debug: - 'WMFSDKVersion' = '10.00.00.3646' asf debug: - 'WMFSDKNeeded' = '0.0.0.0000' asf debug: - 'IsVBR' = 'false' asf debug: found object guid: 0x75b22633-0x668e-0x11cf-0xa6d900aa0062ce6c size:42 asf debug: read "content description object" title:"" artist:"" copyright:"" description:"" rating:"" asf debug: found object guid: 0x8cabdca1-0xa947-0x11cf-0x8ee400c00c205365 size:104 asf debug: read "file properties object" file_id:0xd8b768ee-0x2588-0x4fce-0x8b44a9b4d6b54a9c file_size:4012694 creation_date:128528377726710000 data_packets_count:871 play_duration:890400000 send_duration:887100000 preroll:4000 flags:2 min_data_packet_size:4600 max_data_packet_size:4600 max_bitrate:376822 asf debug: found object guid: 0x5fbf03b5-0xa92e-0x11cf-0x8ee300c00c205365 size:4437 asf debug: read "header extension object" reserved1:0xabd3d211-0xa9ba-0x11cf-0x8ee600c00c205365 reserved2:6 header_extension_size:4391 asf debug: found object guid: 0x7c4346a9-0xefe0-0x4bfc-0xb229393ede415c85 size:33 asf debug: read "language list object" 1 entries asf debug: - 'hu' asf debug: found object guid: 0x26f18b5d-0x4584-0x47ec-0x9f5f0e651f0452c9 size:26 asf warning: unknown asf object (not loaded) asf debug: found object guid: 0xc5f8cbea-0x5baf-0x4877-0x8467aa8c44fa4cca size:354 asf debug: read "metadata object" 6 entries asf debug: - IsVBR=0 asf debug: - DeviceConformanceTemplate=L1 asf debug: - IsVBR=0 asf debug: - DeviceConformanceTemplate=MP@LL asf debug: - WM/WMADRCPeakReference=32767 asf debug: - WM/WMADRCAverageReference=7159 asf debug: found object guid: 0x1806d474-0xcadf-0x4509-0xa4ba9aabcb96aae8 size:3720 asf warning: unknown asf object (not loaded) asf debug: found object guid: 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:88 asf debug: read "extended stream properties object": asf debug: - start=0 end=0 asf debug: - data bitrate=64040 buffer=1579 initial fullness=0 asf debug: - alternate data bitrate=64040 buffer=1579 initial fullness=0 asf debug: - maximum object size=1487 asf debug: - flags=0x2 asf debug: - stream number=1 language=0 asf debug: - average time per frame=1742795 asf debug: - stream name count=0 asf debug: - payload extension system count=0 asf debug: found object guid: 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:132 asf debug: read "extended stream properties object": lua debug: Trying Lua scripts in C:\Users\Kostas\AppData\Roaming\vlc\lua\meta\art asf debug: - start=0 end=0 asf debug: - data bitrate=304000 buffer=4000 initial fullness=0 asf debug: - alternate data bitrate=304000 buffer=4000 initial fullness=0 asf debug: - maximum object size=16000 asf debug: - flags=0x2 asf debug: - stream number=2 language=0 asf debug: - average time per frame=400000 lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art asf debug: - stream name count=0 asf debug: - payload extension system count=2 asf debug: found object guid: 0xd9aade20-0x7c17-0x4f9c-0xbc288555dd98e2a2 size:38 asf warning: unknown asf object (not loaded) asf debug: found object guid: 0x86d15240-0x311d-0x11d0-0xa3a400a0c90348f6 size:244 asf debug: read "codec list object" reserved_guid:0x86d15241-0x311d-0x11d0-0xa3a400a0c90348f6 codec_entries_count:2 asf debug: - codec[0] audio name:"Windows Media Audio 9.1" description:" 64 kbps, 44 kHz, stereo (A/V) 1-pass CBR" information_length:2 asf debug: - codec[1] video name:"Windows Media Video 9" description:"" information_length:4 asf debug: found object guid: 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:114 asf 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:0x1 stream_number:1 asf debug: found object guid: 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:133 asf 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:55 error_correction_data_length:0 flags:0x2 stream_number:2 asf debug: found object guid: 0x7bf875ce-0x468d-0x11d1-0x8d82006097c9a2b2 size:38 asf debug: read "stream bitrate properties object" asf debug: - stream=1 bitrate=65734 asf debug: - stream=2 bitrate=311088 lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\01_googleimage.lua asf debug: found object guid: 0x75b22636-0x668e-0x11cf-0xa6d900aa0062ce6c size:4006650 asf debug: read "data object" file_id:0xd8b768ee-0x2588-0x4fce-0x8b44a9b4d6b54a9c total data packet:871 reserved:257 asf debug: found object guid: 0x33000890-0xe5b1-0x11cf-0x89f400a0c90349cb size:602 asf debug: read "index object" file_id:0xd8b768ee-0x2588-0x4fce-0x8b44a9b4d6b54a9c index_entry_time_interval:10000000 max_packet_count:4 index_entry_count:91 asf debug: + 'Unknown' GUID 0x0-0x0-0x0-0x0000000000000000 size:0pos:0 asf debug: + 'Header' GUID 0x75b22630-0x668e-0x11cf-0xa6d900aa0062ce6c size:5442pos:0 asf debug: | + 'Extended content description' GUID 0xd2d0a440-0xe307-0x11d2-0x97f000a0c95ea850 size:300pos:30 asf debug: | + 'Content Description' GUID 0x75b22633-0x668e-0x11cf-0xa6d900aa0062ce6c size:42pos:330 asf debug: | + 'File Properties' GUID 0x8cabdca1-0xa947-0x11cf-0x8ee400c00c205365 size:104pos:372 asf debug: | + 'Header Extension' GUID 0x5fbf03b5-0xa92e-0x11cf-0x8ee300c00c205365 size:4437pos:476 asf debug: | | + 'Language List' GUID 0x7c4346a9-0xefe0-0x4bfc-0xb229393ede415c85 size:33pos:522 asf debug: | | + 'Unknown' GUID 0x26f18b5d-0x4584-0x47ec-0x9f5f0e651f0452c9 size:26pos:555 asf debug: | | + 'Metadata' GUID 0xc5f8cbea-0x5baf-0x4877-0x8467aa8c44fa4cca size:354pos:581 asf debug: | | + 'Padding' GUID 0x1806d474-0xcadf-0x4509-0xa4ba9aabcb96aae8 size:3720pos:935 asf debug: | | + 'Extended Stream Properties' GUID 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:88pos:4655 asf debug: | | + 'Extended Stream Properties' GUID 0x14e6a5cb-0xc672-0x4332-0x8399a96952065b5a size:132pos:4743 asf debug: | | + 'Unknown' GUID 0xd9aade20-0x7c17-0x4f9c-0xbc288555dd98e2a2 size:38pos:4875 asf debug: | + 'Codec List' GUID 0x86d15240-0x311d-0x11d0-0xa3a400a0c90348f6 size:244pos:4913 asf debug: | + 'Stream Properties' GUID 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:114pos:5157 asf debug: | + 'Stream Properties' GUID 0xb7dc0791-0xa9b7-0x11cf-0x8ee600c00c205365 size:133pos:5271 asf debug: | + 'Stream Bitrate Properties' GUID 0x7bf875ce-0x468d-0x11d1-0x8d82006097c9a2b2 size:38pos:5404 asf debug: + 'Data' GUID 0x75b22636-0x668e-0x11cf-0xa6d900aa0062ce6c size:4006650pos:5442 asf debug: + 'Index' GUID 0x33000890-0xe5b1-0x11cf-0x89f400a0c90349cb size:602pos:4012092 asf debug: found 2 streams asf debug: added new audio stream(codec:0x161,ID:1) main debug: selecting program id=0 asf debug: added new video stream(ID:2) lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\02_frenchtv.lua main debug: using demux module "asf" main debug: TIMER module_need() : 4.000 ms - Total 4.000 ms / 1 intvls (Avg 4.000 ms) main debug: looking for a subtitle file in C:\Users\Kostas\Desktop\ lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\03_lastfm.lua main debug: looking for decoder module: 34 candidates avcodec debug: libavcodec already initialized lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\art\04_musicbrainz.lua main debug: no art finder module matching "any" could be loaded main debug: TIMER module_need() : 7.000 ms - Total 7.000 ms / 1 intvls (Avg 7.000 ms) main debug: art not found for Children - Funny videos.wmv avcodec debug: ffmpeg codec (Windows Media Audio 2) started avcodec debug: Using 192000 bytes output buffer main debug: using decoder module "avcodec" main debug: TIMER module_need() : 3.000 ms - Total 3.000 ms / 1 intvls (Avg 3.000 ms) main debug: thread (decoder) created at priority 2 (../.././src/input/decoder.c:301) main debug: thread started main debug: looking for decoder module: 34 candidates avcodec debug: libavcodec already initialized avcodec debug: trying to use direct rendering avcodec debug: ffmpeg codec (Windows Media Video 9) started main debug: using decoder module "avcodec" main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: thread (decoder) created at priority 0 (../.././src/input/decoder.c:301) main debug: thread started main debug: looking for meta reader module: 2 candidates lua debug: Trying Lua scripts in C:\Users\Kostas\AppData\Roaming\vlc\lua\meta\reader lua debug: Trying Lua scripts in C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader lua debug: Trying Lua playlist script C:\Program Files (x86)\VideoLAN\VLC\lua\meta\reader\filename.lua main debug: no meta reader module matching "any" could be loaded main debug: TIMER module_need() : 2.000 ms - Total 2.000 ms / 1 intvls (Avg 2.000 ms) main debug: `file:///C:/Users/Kostas/Desktop/Children%20-%20Funny%20videos.wmv' successfully opened main debug: Buffering 0% main debug: Buffering 13% main debug: Buffering 26% main debug: Buffering 26% main debug: Buffering 66% main debug: Buffering 93% main debug: Stream buffering done (400 ms in 1 ms) main debug: no usable vout present, spawning one main debug: looking for text renderer module: 2 candidates freetype debug: Using Arial as font from file C:\Windows\Fonts\arial.ttf freetype debug: using fontsize: 2 main debug: using text renderer module "freetype" main debug: TIMER module_need() : 2.000 ms - Total 2.000 ms / 1 intvls (Avg 2.000 ms) main debug: looking for video filter2 module: 18 candidates swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: YUVA with scaling using Bicubic (good quality) main debug: using video filter2 module "swscale" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: looking for video filter2 module: 18 candidates yuvp debug: YUVP to YUVA converter main debug: using video filter2 module "yuvp" main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: window size: 320x240 main debug: Deinterlacing available main debug: deinterlace 0, mode blend, is_needed 0 main debug: looking for video output module: 1 candidate vout_wrapper debug: Opening vout display wrapper main debug: looking for vout display module: 8 candidates direct3d debug: creating Vout EventThread direct3d debug: DirectXCreateWindow main debug: looking for vout window hwnd module: 3 candidates qt4 debug: requesting video... qt4 debug: IM: Setting an input qt4 debug: Video was requested 0, 0 main debug: using vout window hwnd module "qt4" main debug: TIMER module_need() : 290.000 ms - Total 290.000 ms / 1 intvls (Avg 290.000 ms) direct3d debug: created video sub-window direct3d debug: Vout EventThread running direct3d debug: disabling screen saver main debug: VoutDisplayEvent 'resize' 336x278 window direct3d warning: trying surface pixel format: YV12 direct3d debug: selected surface pixel format is YV12 direct3d debug: Direct3D scene created successfully direct3d debug: Direct3D device adapter successfully initialized main debug: using vout display module "direct3d" main debug: TIMER module_need() : 391.000 ms - Total 391.000 ms / 1 intvls (Avg 391.000 ms) main debug: using video output module "vout_wrapper" main debug: TIMER module_need() : 392.000 ms - Total 392.000 ms / 1 intvls (Avg 392.000 ms) main debug: got 1 direct buffer(s) main debug: pic render sz 320x240, of (0,0), vsz 320x240, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: pic in sz 320x240, of (0,0), vsz 320x240, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: pic out sz 320x240, of (0,0), vsz 320x240, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0 main debug: direct render, mapping render pictures 0-23 to system pictures 1-24 main debug: VoutDisplayEvent 'resize' 1440x736 window avcodec debug: using direct rendering main debug: End of video preroll main debug: Received first picture freetype debug: using fontsize: 15 main debug: looking for video blending module: 1 candidate blend debug: chroma: YUVA -> I420 main debug: using video blending module "blend" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: Decoder buffering done in 407 ms main debug: Post-processing available main warning: vlc_object_find_name(postproc) is not safe! avcodec warning: Physical channel configuration not set : guessing main debug: reusing aout main debug: looking for audio output module: 4 candidates aout_directx debug: Opening DirectSound Audio Output main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 300 ms) main debug: ES_OUT_RESET_PCR called aout_directx debug: found device: Primary Sound Driver aout_directx debug: found device: Speakers (SoundMAX Integrated Digital HD Audio) aout_directx debug: device supports 2 channels (DEFAULT!) aout_directx debug: device supports 1 channel aout_directx debug: Windows says your SpeakerConfig is stereo aout_directx debug: creating DirectSoundThread main debug: thread started aout_directx debug: DirectSoundThread ready main debug: thread (DirectSound Notification Thread) created at priority 15 (../../.././modules/audio_output/directx.c:321) main debug: using audio output module "aout_directx" main debug: TIMER module_need() : 21.000 ms - Total 21.000 ms / 1 intvls (Avg 21.000 ms) main debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: mixer 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes main debug: filter(s) 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 13 candidates audio_format debug: f32l->s16l, bits per sample: 32->16 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) 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: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: input 's16l' 44100 Hz Stereo frame=1 samples/4 bytes main debug: looking for audio filter module: 1 candidate scaletempo debug: format: 44100 rate, 2 nch, 4 bps, fl32 scaletempo debug: params: 30 stride, 0.200 overlap, 14 search scaletempo debug: 1.000 scale, 1323.000 stride_in, 1323 stride_out, 1059 standing, 264 overlap, 617 search, 2204 queue, fl32 mode main debug: using audio filter module "scaletempo" main debug: TIMER module_need() : 1.000 ms - Total 1.000 ms / 1 intvls (Avg 1.000 ms) main debug: filter(s) 's16l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 13 candidates audio_format debug: s16l->f32l, bits per sample: 16->32 main debug: using audio filter module "audio_format" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: found a filter for the whole conversion main debug: filter(s) 'f32l'->'f32l' 48510 Hz->44100 Hz Stereo->Stereo main debug: looking for audio filter module: 13 candidates main debug: using audio filter module "ugly_resampler" main debug: TIMER module_need() : 0.000 ms - Total 0.000 ms / 1 intvls (Avg 0.000 ms) main debug: found a filter for the whole conversion main debug: End of audio preroll main warning: received buffer in the future main debug: Buffering 0% main debug: Buffering 45% main debug: Buffering 70% main debug: Stream buffering done (349 ms in 0 ms) main debug: End of audio preroll main debug: End of video preroll main debug: Received first picture main debug: Decoder buffering done in 5 ms main debug: auto hidding mouse main debug: control type=1 main debug: auto hidding mouse
Though, I've found other wmv files that play ok, eg. http://www.rustycooley.com/videos/rusty ... luence.wmv :?

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 19 Dec 2011 19:22
by VLC_help
I'll check the file during weekend.

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 26 Dec 2011 20:08
by VLC_help
Remuxing with tool called asfbin seems to fix it.
http://www.megaupload.com/?d=O8XBP05X

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 07 Mar 2012 00:11
by quality
The problem still exists in VLC 2.0

@VLC_help
Thanks for taking the time checking this issue.

Re: (VLC v1.1.11) Pause for 1 sec when playing WMV files

Posted: 07 Mar 2012 19:57
by VLC_help
ASF demuxer hasn't got enough love during last year. So most likely broken/damaged ASF/WMV files won't playback any better in future. (unless you remux them)