2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Microsoft Windows specific usage questions
Forum rules
Please post only Windows specific questions in this forum category. If you don't know where to post, please read the different forums' rules. Thanks.
Puppy8
Blank Cone
Blank Cone
Posts: 16
Joined: 02 Nov 2012 22:48
Operating System: Windows

2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Puppy8 » 05 Mar 2015 10:58

When I start to play a WMA track or move to the next track in playlist, it plays first ~ 500 ms, then stops for another ~ 500 ms and continues to play the rest of track. Older 2.1.5 version did not have the issue.

Code: Select all

core debug: processing request item: 1234567890, node: Media Library, skip: 0 core debug: resyncing on 1234567890 core debug: 1234567890 is at 24 core debug: starting playback of the new playlist item core debug: resyncing on 1234567890 core debug: 1234567890 is at 24 core debug: creating new input thread core debug: Creating an input for '1234567890' core debug: using timeshift granularity of 50 MiB, in path 'C:\DOCUME~1\User\LOCALS~1\Temp' core debug: requesting art for 1234567890 core debug: `file:///C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma' gives access `file' demux `' path `/C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma' core debug: specified demux `any' core debug: creating demux: access='file' demux='any' location='/C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma' file='C:\Documents and Settings\User\My Documents\My Music\2014\[-ABCD-] - 1234567890 {111111111}\02 1234567890.wma' core debug: looking for access_demux module matching "file": 12 candidates core debug: no access_demux modules matched core debug: creating access 'file' location='/C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma', path='C:\Documents and Settings\User\My Documents\My Music\2014\[-ABCD-] - 1234567890 {111111111}\02 1234567890.wma' core debug: looking for access module matching "file": 21 candidates filesystem debug: opening file `C:\Documents and Settings\User\My Documents\My Music\2014\[-ABCD-] - 1234567890 {111111111}\02 1234567890.wma' core debug: using access module "filesystem" core debug: Using stream method for AStream* core debug: starting pre-buffering core debug: received first data after 0 ms core debug: pre-buffering done 1024 bytes in 0s - 1000000 KiB/s core debug: looking for stream_filter module matching "any": 6 candidates core debug: no stream_filter modules matched core debug: looking for stream_filter module matching "record": 6 candidates core debug: using stream_filter module "record" core debug: creating demux: access='file' demux='any' location='/C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma' file='C:\Documents and Settings\User\My Documents\My Music\2014\[-ABCD-] - 1234567890 {111111111}\02 1234567890.wma' core debug: looking for demux module matching "asf": 65 candidates asf warning: unknown asf object (not loaded): 0xd6e229df-0x35da-0x11d1-0x903400a0c90349be asf warning: unknown asf object (not loaded): 0xd6e229d3-0x35da-0x11d1-0x903400a0c90349be asf warning: unknown top-level object found: 0xd6e229d3-0x35da-0x11d1-0x903400a0c90349be asf debug: + 'Root' asf debug: | + 'Header' asf debug: | | + 'File Properties' asf debug: | | + 'Header Extension' asf debug: | | | + 'Object Compatibility' asf debug: | | | + 'Metadata' asf debug: | | | + 'Padding' asf debug: | | | + 'Extended Stream Properties' asf debug: | | | + 'Unknown' asf debug: | | + 'Extended content description' asf debug: | | + 'Codec List' asf debug: | | + 'Stream Properties' asf debug: | | + 'Stream Bitrate Properties' asf debug: | | + 'Content Description' asf debug: | + 'Data' asf debug: | + 'Index' asf debug: | + 'Simple Index' asf debug: found 1 streams asf debug: added new audio stream(codec:0x161,ID:1) core debug: selecting program id=0 core debug: using demux module "asf" core debug: looking for a subtitle file in C:\Documents and Settings\User\My Documents\My Music\2014\[-ABCD-] - 1234567890 {111111111}\ core debug: looking for decoder module matching "any": 43 candidates avcodec debug: CPU flags: 0x4100100b avcodec debug: avcodec codec (Windows Media Audio 2) started core debug: using decoder module "avcodec" core debug: looking for meta reader module matching "any": 2 candidates core debug: using meta reader module "taglib" core debug: removing module "taglib" core debug: `file:///C:/Documents%20and%20Settings/User/My%20Documents/My%20Music/2014/%5B-ABCD-%5D%20-%201234567890%20%111111111%7D/02%201234567890.wma' successfully opened avcodec warning: Physical channel configuration not set : guessing core debug: reusing audio output directsound debug: Opening DirectSound Audio Output core debug: Buffering 0% core debug: Stream buffering done (482 ms in 0 ms) core debug: looking for meta fetcher module matching "any": 1 candidates lua debug: Trying Lua scripts in C:\Documents and Settings\User\Application Data\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac core debug: no meta fetcher modules matched core debug: ABCD - 1234567890 has already been searched core debug: art not found for 1234567890 directsound debug: Windows speaker config: Stereo and stream has 2 channels, using 2 channels core debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes core debug: looking for audio volume module matching "any": 2 candidates core debug: using audio volume module "float_mixer" core debug: input 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes core debug: looking for audio filter module matching "scaletempo": 14 candidates 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 core debug: using audio filter module "scaletempo" core debug: conversion: 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo core debug: conversion pipeline complete core debug: conversion: 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo core debug: conversion pipeline complete core debug: looking for audio resampler module matching "any": 3 candidates core debug: using audio resampler module "samplerate" core debug: End of audio preroll core debug: Decoder wait done in 120 ms core warning: buffer too late (-129000 us): dropped core warning: playback way too early (-207626): playing silence core debug: inserting 9156 zeroes qt4 debug: IM: Setting an input core debug: incoming request - stopping current input core debug: control: stopping input core debug: incoming request - stopping current input core debug: finished input core debug: removing module "avcodec" avcodec debug: ffmpeg codec (Windows Media Audio 2) stopped core debug: killing decoder fourcc `WMA2', 0 PES in FIFO core debug: removing module "samplerate" core debug: removing module "scaletempo" directsound debug: closing audio device core debug: removing module "float_mixer" core debug: keeping audio output core debug: removing module "asf" core debug: Program doesn't contain anymore ES core debug: removing module "record" core debug: removing module "filesystem" core debug: incoming request - stopping current input core debug: dead input qt4 debug: IM: Deleting the input

Lotesdelere
Cone Master
Cone Master
Posts: 9959
Joined: 08 Sep 2006 04:39
Location: Europe

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Lotesdelere » 06 Mar 2015 13:54

I can't reproduce the issue, no problem here with v2.2.0 so far.

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.

Also upload a short sample of a problematic file to either http://streams.videolan.org/upload/ or to Zippyshare.com (200 MB max) or to EmbedUpload.com, the latter will upload the file for you to several other hosts (use the default ones) and then post the link to the file here.

Puppy8
Blank Cone
Blank Cone
Posts: 16
Joined: 02 Nov 2012 22:48
Operating System: Windows

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Puppy8 » 09 Mar 2015 13:49

It is full log after pressing Play button.

Lotesdelere
Cone Master
Cone Master
Posts: 9959
Joined: 08 Sep 2006 04:39
Location: Europe

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Lotesdelere » 09 Mar 2015 14:03

We still need a short sample file.

Puppy8
Blank Cone
Blank Cone
Posts: 16
Joined: 02 Nov 2012 22:48
Operating System: Windows

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Puppy8 » 20 Mar 2015 21:09

I made short 30 sec sample. It is sine wave created by Audacity and converted to WMA2 by Microsoft Expression Encoder 4. Notice the dropout at 0:01 position. The dropout also occurs in one second after seeking to a different position. There is no issue playing the sample file in VLC 2.1.5.

Sample file (518 KB): http://members.upc.cz/petr/temp/VLC220_ ... sample.wma

VLC 2.2.0 log:

Code: Select all

core debug: processing request item: null, node: Playlist, skip: 0 core debug: rebuilding array of current - root Playlist core debug: rebuild done - 1 items, index -1 core debug: starting playback of the new playlist item core debug: resyncing on VLC220_WMA2_dropout_bug_sample.wma core debug: VLC220_WMA2_dropout_bug_sample.wma is at 0 core debug: creating new input thread core debug: Creating an input for 'VLC220_WMA2_dropout_bug_sample.wma' core debug: requesting art for VLC220_WMA2_dropout_bug_sample.wma qt4 debug: IM: Setting an input core debug: using timeshift granularity of 50 MiB, in path 'C:\DOCUME~1\Petr\LOCALS~1\Temp' core debug: `file:///C:/Pack/VLC220_WMA2_dropout_bug_sample.wma' gives access `file' demux `' path `/C:/Pack/VLC220_WMA2_dropout_bug_sample.wma' core debug: specified demux `any' core debug: creating demux: access='file' demux='any' location='/C:/Pack/VLC220_WMA2_dropout_bug_sample.wma' file='C:\Pack\VLC220_WMA2_dropout_bug_sample.wma' core debug: looking for access_demux module matching "file": 12 candidates core debug: no access_demux modules matched core debug: creating access 'file' location='/C:/Pack/VLC220_WMA2_dropout_bug_sample.wma', path='C:\Pack\VLC220_WMA2_dropout_bug_sample.wma' core debug: looking for access module matching "file": 21 candidates filesystem debug: opening file `C:\Pack\VLC220_WMA2_dropout_bug_sample.wma' core debug: using access module "filesystem" core debug: Using stream method for AStream* core debug: starting pre-buffering core debug: received first data after 3 ms core debug: pre-buffering done 1024 bytes in 0s - 333 KiB/s core debug: looking for stream_filter module matching "any": 6 candidates core debug: no stream_filter modules matched core debug: looking for stream_filter module matching "record": 6 candidates core debug: using stream_filter module "record" core debug: creating demux: access='file' demux='any' location='/C:/Pack/VLC220_WMA2_dropout_bug_sample.wma' file='C:\Pack\VLC220_WMA2_dropout_bug_sample.wma' core debug: looking for demux module matching "asf": 65 candidates asf warning: unknown asf object (not loaded): 0xd6e229df-0x35da-0x11d1-0x903400a0c90349be asf warning: unknown asf object (not loaded): 0xd6e229d3-0x35da-0x11d1-0x903400a0c90349be asf warning: unknown top-level object found: 0xd6e229d3-0x35da-0x11d1-0x903400a0c90349be asf debug: + 'Root' asf debug: | + 'Header' asf debug: | | + 'File Properties' asf debug: | | + 'Header Extension' asf debug: | | | + 'Language List' asf debug: | | | + 'Object Compatibility' asf debug: | | | + 'Metadata' asf debug: | | | + 'Padding' asf debug: | | | + 'Extended Stream Properties' asf debug: | | | + 'Unknown' asf debug: | | + 'Extended content description' asf debug: | | + 'Codec List' asf debug: | | + 'Stream Properties' asf debug: | | + 'Stream Bitrate Properties' asf debug: | + 'Data' asf debug: | + 'Index' asf debug: | + 'Simple Index' asf debug: found 1 streams asf debug: added new audio stream(codec:0x161,ID:1) core debug: selecting program id=0 core debug: using demux module "asf" core debug: looking for a subtitle file in C:\Pack\ core debug: looking for decoder module matching "any": 43 candidates avcodec debug: CPU flags: 0x4100107f avcodec debug: avcodec codec (Windows Media Audio 2) started core debug: using decoder module "avcodec" core debug: looking for meta reader module matching "any": 2 candidates core debug: using meta reader module "taglib" core debug: removing module "taglib" core debug: `file:///C:/Pack/VLC220_WMA2_dropout_bug_sample.wma' successfully opened avcodec warning: Physical channel configuration not set : guessing core debug: reusing audio output directsound debug: Opening DirectSound Audio Output core debug: Buffering 0% core debug: Stream buffering done (696 ms in 0 ms) core debug: looking for meta fetcher module matching "any": 1 candidates lua debug: Trying Lua scripts in C:\Documents and Settings\Petr\Application Data\vlc\lua\meta\fetcher lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\fetcher\tvrage.luac core debug: no meta fetcher modules matched core debug: searching art for VLC220_WMA2_dropout_bug_sample.wma core debug: looking for art finder module matching "any": 2 candidates lua debug: Trying Lua scripts in C:\Documents and Settings\Petr\Application Data\vlc\lua\meta\art lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\art lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac core debug: no art finder modules matched core debug: art not found for VLC220_WMA2_dropout_bug_sample.wma directsound debug: Windows speaker config: Stereo and stream has 2 channels, using 2 channels core debug: output 's16l' 44100 Hz Stereo frame=1 samples/4 bytes core debug: looking for audio volume module matching "any": 2 candidates core debug: using audio volume module "integer_mixer" core debug: input 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes core debug: conversion: 'f32l'->'s16l' 44100 Hz->44100 Hz Stereo->Stereo core debug: looking for audio converter module matching "any": 12 candidates audio_format debug: f32l->s16l, bits per sample: 32->16 core debug: using audio converter module "audio_format" core debug: conversion pipeline complete core debug: looking for audio resampler module matching "any": 3 candidates core debug: using audio resampler module "ugly_resampler" core debug: End of audio preroll core debug: Decoder wait done in 166 ms core warning: buffer too late (-380000 us): dropped core warning: playback way too early (-260876): playing silence core debug: inserting 11504 zeroes

Jean-Baptiste Kempf
Site Administrator
Site Administrator
Posts: 37523
Joined: 22 Jul 2005 15:29
VLC version: 4.0.0-git
Operating System: Linux, Windows, Mac
Location: Cone, France
Contact:

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Jean-Baptiste Kempf » 22 Mar 2015 22:40

You should create a bugreport, mentioning it's a regression.
Jean-Baptiste Kempf
http://www.jbkempf.com/ - http://www.jbkempf.com/blog/category/Videolan
VLC media player developer, VideoLAN President and Sites administrator
If you want an answer to your question, just be specific and precise. Don't use Private Messages.

Puppy8
Blank Cone
Blank Cone
Posts: 16
Joined: 02 Nov 2012 22:48
Operating System: Windows

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Puppy8 » 25 Mar 2015 12:58


Jean-Baptiste Kempf
Site Administrator
Site Administrator
Posts: 37523
Joined: 22 Jul 2005 15:29
VLC version: 4.0.0-git
Operating System: Linux, Windows, Mac
Location: Cone, France
Contact:

Re: 2.2.0 playing WMA tracks ~ 500 ms silence gap at start

Postby Jean-Baptiste Kempf » 25 Mar 2015 23:34

Ok.
Jean-Baptiste Kempf
http://www.jbkempf.com/ - http://www.jbkempf.com/blog/category/Videolan
VLC media player developer, VideoLAN President and Sites administrator
If you want an answer to your question, just be specific and precise. Don't use Private Messages.


Return to “VLC media player for Windows Troubleshooting”

Who is online

Users browsing this forum: No registered users and 25 guests