Audio pauses every 2 seconds

[Medes]

Hi All, I have a problem when I try to play audio or video files using VLC 2.1.2. Audio plays with pauses. Everything was OK with 1.x and first 2.x versions. It appeared about two months ago, but it wasn't so bad. Now audio pauses every 3 seconds.

VLC log contains this:

main warning: playback too late (70583): up-sampling
main warning: timing screwed (drift: 146937 us): stopping resampling
main warning: playback too late (149895): up-sampling
main warning: playback way too late (188833): flushing buffers
main debug: inserting 19536 zeroes
main warning: playback too late (67979): up-sampling
main warning: timing screwed (drift: 136854 us): stopping resampling
main warning: playback too late (137812): up-sampling
main warning: playback way too late (181750): flushing buffers
main debug: inserting 19392 zeroes
main warning: playback too late (68000): up-sampling
main warning: timing screwed (drift: 136916 us): stopping resampling
main warning: playback too late (149875): up-sampling
main warning: playback way too late (185812): flushing buffers
main debug: inserting 19536 zeroes
main warning: playback too late (61979): up-sampling
main warning: timing screwed (drift: 124625 us): stopping resampling
main warning: playback too late (100604): up-sampling
main warning: playback way too late (192187): flushing buffers
main debug: inserting 19392 zeroes
main warning: playback too late (63979): up-sampling
main warning: timing screwed (drift: 130270 us): stopping resampling
main warning: playback too late (131229): up-sampling
main warning: playback way too late (180833): flushing buffers
main debug: inserting 21312 zeroes

I tried to increase file caching time in Input/Codecs, but it doesn't help. How can I solve this problem?

[Medes]

Okay, I tried to install older versions of VLC. Seems like this problem appears in ver. 2.1.0, because in version 2.0.8 all files plays normally.

[Jean-Baptiste Kempf]

What OS?

[Medes]

Windows 7 x64.

[Jean-Baptiste Kempf]

To help you, we need messages, to completely understand what your problems is.
To fix this, please be sure before you start the playback to:

1. Open: Tools -> Messages.
2. Set Verbosity to 2
3. Start playback to reproduce your issue
4. Save text in a file or copy into clipboard
5. Then paste the full resulting log here between [​code]and[​/code] (or use Pastebin.com if it's too long)

Also don't forget to name your Operating System and provide the VLC media player version.

[SpaceMonkey]

I have the same issue with some flv video files.

I believe the stutter occurs when the 'inserting XXXXX zeroes' occurs.

Here are the messages:

main debug: processing request item: 4ff5c1c2.flv, node: Playlist, skip: 0
main debug: resyncing on 4ff5c1c2.flv
main debug: 4ff5c1c2.flv is at 0
main debug: starting playback of the new playlist item
main debug: resyncing on 4ff5c1c2.flv
main debug: 4ff5c1c2.flv is at 0
main debug: creating new input thread
main debug: Creating an input for '4ff5c1c2.flv'
main debug: using timeshift granularity of 50 MiB, in path 'C:\Users\spacemonkey\AppData\Local\Temp'
main debug: `file:///C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv' gives access `file' demux `' path `/C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv'
main debug: creating demux: access='file' demux='' location='/C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv' file='C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\4ff5c1c2.flv'
main debug: looking for access_demux module matching "file": 12 candidates
main debug: no access_demux modules matched
main debug: creating access 'file' location='/C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv', path='C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\4ff5c1c2.flv'
main debug: looking for access module matching "file": 20 candidates
filesystem debug: opening file `C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\4ff5c1c2.flv'
main debug: using access module "filesystem"
main debug: Using stream method for AStream*
main debug: starting 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 matching "any": 6 candidates
main debug: no stream_filter modules matched
main debug: looking for stream_filter module matching "record": 6 candidates
main debug: using stream_filter module "record"
main debug: creating demux: access='file' demux='' location='/C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv' file='C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\4ff5c1c2.flv'
main debug: looking for demux module matching "any": 63 candidates
mod debug: MOD validation failed (ext=flv)
ts debug: TS module discarded (lost sync)
avcodec debug: trying url: C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\4ff5c1c2.flv
avcodec debug: detected format: flv
qt4 debug: IM: Setting an input
main debug: selecting program id=0
avcodec debug: adding es: video codec = h264 (28)
avcodec debug: adding es: audio codec = mp4a (86018)
avcodec debug: AVFormat supported stream
avcodec debug: - format = flv (FLV (Flash Video))
avcodec debug: - start time = 0
avcodec debug: - duration = 60055000
main debug: using demux module "avcodec"
main debug: looking for a subtitle file in C:\Users\spacemonkey\Documents\Development\VLC experiments\videos\
main debug: looking for decoder module matching "any": 39 candidates
avcodec debug: trying to use direct rendering
avcodec debug: allowing 4 thread(s) for decoding
avcodec debug: avcodec codec (H264 - MPEG-4 AVC (part 10)) started
avcodec debug: using frame thread mode with 4 threads
main debug: using decoder module "avcodec"
main debug: looking for decoder module matching "any": 39 candidates
main debug: using decoder module "faad"
main debug: looking for meta reader module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\spacemonkey\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.luac
main debug: no meta reader modules matched
main debug: `file:///C:/Users/spacemonkey/Documents/Development/VLC%20experiments/videos/4ff5c1c2.flv' successfully opened
main debug: Buffering 0%
main debug: Buffering 0%
main debug: Buffering 0%
main debug: Buffering 0%
main debug: Buffering 0%
main debug: Buffering 11%
main debug: Buffering 21%
main debug: Buffering 21%
main debug: Buffering 33%
main debug: Buffering 33%
main debug: Buffering 33%
faad warning: decoded zero sample
main debug: looking for text renderer module matching "any": 2 candidates
faad warning: Bitstream value not allowed by specification
faad warning: Unexpected channel configuration change
freetype debug: Using Arial as font from file C:\windows\Fonts\ariali.ttf
faad warning: decoded zero sample
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: looking for video filter2 module matching "any": 55 candidates
main debug: Buffering 33%
main debug: Buffering 33%
main debug: Buffering 44%
main debug: Buffering 54%
main debug: Buffering 54%
main debug: Buffering 66%
main debug: Buffering 66%
main debug: Buffering 66%
main debug: Buffering 66%
main debug: Buffering 77%
main debug: Buffering 86%
main debug: Buffering 89%
main debug: Buffering 89%
swscale debug: 32x32 chroma: YUVA -> 16x16 chroma: RGBA with scaling using Bicubic (good quality)
main debug: using video filter2 module "swscale"
main debug: looking for video filter2 module matching "any": 55 candidates
yuvp debug: YUVP to YUVA converter
main debug: using video filter2 module "yuvp"
main debug: Buffering 89%
main debug: Buffering 100%
main debug: Stream buffering done (316 ms in 2 ms)
main debug: Deinterlacing available
main debug: deinterlace 0, mode blend, is_needed 0
main debug: Opening vout display wrapper
main debug: looking for vout display module matching "any": 10 candidates
direct3d debug: creating Vout EventThread
direct3d debug: DirectXCreateWindow
main debug: looking for vout window hwnd module matching "qt4,any": 3 candidates
qt4 debug: requesting video window...
qt4 debug: Video was requested 0, 0
main debug: using vout window hwnd module "qt4"
direct3d debug: created video sub-window
direct3d debug: Vout EventThread running
direct3d debug: disabling screen saver
direct3d debug: Direct3d Device: Intel(R) HD Graphics Family 32902 2582 11
main debug: VoutDisplayEvent 'resize' 738x527 window
direct3d warning: trying surface pixel format: YV12
direct3d debug: selected surface pixel format is YV12
direct3d debug: Using D3DTEXF_LINEAR for minification
direct3d debug: Using D3DTEXF_LINEAR for magnification
direct3d debug: Direct3D scene created successfully
direct3d debug: Direct3D device adapter successfully initialized
main debug: using vout display module "direct3d"
main debug: original format sz 720x480, of (0,0), vsz 720x480, 4cc I420, sar 1:1, msk r0x0 g0x0 b0x0
main debug: removing module "freetype"
main debug: looking for text renderer module matching "any": 2 candidates
main debug: VoutDisplayEvent 'resize' 720x480 window
freetype debug: Using Arial as font from file C:\windows\Fonts\ariali.ttf
freetype debug: using fontsize: 2
main debug: using text renderer module "freetype"
main debug: reusing audio output
avcodec debug: using direct rendering
directsound debug: Opening DirectSound Audio Output
main debug: End of video preroll
main debug: Received first picture
direct3d debug: Created 157x27 texture for OSD
directsound debug: Windows speaker config: Stereo and stream has 2 channels, using 2 channels
main debug: output 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio volume module matching "any": 2 candidates
main debug: using audio volume module "float_mixer"
main debug: input 'f32l' 44100 Hz Stereo frame=1 samples/8 bytes
main 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
main debug: using audio filter module "scaletempo"
main debug: conversion: 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
main debug: conversion pipeline complete
main debug: conversion: 'f32l'->'f32l' 44100 Hz->44100 Hz Stereo->Stereo
main debug: conversion pipeline complete
main debug: looking for audio resampler module matching "any": 3 candidates
main debug: using audio resampler module "samplerate"
main debug: End of audio preroll
main debug: Decoder buffering done in 122 ms
main debug: inserting 6526 zeroes
main warning: playback too late (65188): up-sampling
main warning: timing screwed (drift: 145603 us): stopping resampling
main warning: playback too late (105800): up-sampling
main warning: playback way too late (185798): flushing buffers
main debug: inserting 19536 zeroes
main debug: auto hiding mouse cursor
main warning: playback too late (60489): up-sampling
main debug: resampling stopped (drift: 18709 us)
main warning: playback too late (64029): up-sampling
main debug: resampling stopped (drift: 16249 us)
main warning: playback too late (70909): up-sampling
main warning: timing screwed (drift: 142412 us): stopping resampling
main warning: playback too late (105587): up-sampling
main warning: playback way too late (182387): flushing buffers
main debug: inserting 20153 zeroes
main warning: playback too late (60800): up-sampling
main debug: resampling stopped (drift: 17020 us)
main warning: playback too late (68680): up-sampling
main warning: timing screwed (drift: 143009 us): stopping resampling
main warning: playback too late (94183): up-sampling
main warning: playback way too late (189970): flushing buffers
main debug: inserting 19977 zeroes
main warning: playback too late (68369): up-sampling
main debug: resampling stopped (drift: 15589 us)
main warning: playback too late (70249): up-sampling
main debug: resampling stopped (drift: 21469 us)
main warning: playback too late (61909): up-sampling
main warning: timing screwed (drift: 128857 us): stopping resampling
main warning: playback too late (77054): up-sampling
main warning: timing screwed (drift: 168240 us): stopping resampling
main warning: playback too late (102460): up-sampling
main warning: playback way too late (187811): flushing buffers
main debug: inserting 19624 zeroes
main warning: playback too late (60068): up-sampling
main debug: resampling stopped (drift: 4287 us)
main warning: playback too late (66145): up-sampling
main debug: resampling stopped (drift: 26365 us)
main warning: playback too late (69804): up-sampling
main debug: resampling stopped (drift: 11024 us)
main warning: playback too late (71684): up-sampling
main debug: resampling stopped (drift: 20904 us)
main warning: playback too late (63564): up-sampling
main warning: timing screwed (drift: 142746 us): stopping resampling
main warning: playback too late (92943): up-sampling
main warning: playback way too late (189832): flushing buffers
main debug: inserting 20462 zeroes
main warning: playback too late (61607): up-sampling
main debug: resampling stopped (drift: 9827 us)
main warning: playback too late (66487): up-sampling
main debug: resampling stopped (drift: 15707 us)
main warning: playback too late (60147): up-sampling
main warning: timing screwed (drift: 133594 us): stopping resampling
main warning: playback too late (92791): up-sampling
main warning: playback way too late (180367): flushing buffers
main debug: inserting 19756 zeroes
main warning: playback too late (61138): up-sampling
main debug: resampling stopped (drift: 9358 us)
main warning: playback too late (68018): up-sampling
main debug: resampling stopped (drift: 14238 us)
main warning: playback too late (75897): up-sampling
main debug: resampling stopped (drift: 23117 us)
main debug: auto hiding mouse cursor
main debug: auto hiding mouse cursor

[SpaceMonkey]

Oops, I assumed the version and OS would be in the log, these are:

Windows 8.1 x64
VLC 2.1.3 Rincewind

I can confirm it did not occur on my previously installed version of VLC, but I cannot remember the version number.

[Jean-Baptiste Kempf]

Can you please test VLC 2.2.0 from nightly builds?

[SpaceMonkey]

2.0.8 In Linux does not exhibit the stuttering issue.
2.2.0 In Linux - NOT TESTED YET.

2.0.8 In windows does not exhibit the stuttering issue.
2.1.0 In windows does not exhibit the stuttering issue.
2.1.1 In windows exhibits the stuttering issue.
2.1.2 In windows exhibits the stuttering issue.
2.1.3 In windows exhibits the stuttering issue.
2.2.0 In windows exhibits the stuttering issue.

[natchie]

Same issue with Windows 7 ultimate x64
VLC 2.1.5

Log looks exactly the same.