Bug#705073: pulseaudio: still having latency issues.

[shirish शिरीष]

Hi all,
upgraded to pulseaudio 5.0 and still have the latency issue happening
at times. While it is random, it is much more easily replicated in vlc
if I forward the video few times (by using CTRL+Right arrow)

[0x254b3c8] pulse audio output debug: base volume: 65536
[0x254b3c8] pulse audio output debug: changing sink 0:
alsa_output.pci-0000_00_1b.0.analog-stereo (Built-in Audio Analog
Stereo)
[0x7fd540010d98] main blend debug: using video blending module "blend"
[0x7fd530000958] main volume debug: using audio volume module "float_mixer"
[0x254b3c8] main audio output debug: input 'a52 ' 48000 Hz 3F2R/LFE
frame=1536 samples/1792 bytes
[0x7fd5300031d8] main audio filter debug: looking for audio filter
module matching "scaletempo": 14 candidates
[0x7fd5300031d8] scaletempo audio filter debug: format: 48000 rate, 6
nch, 4 bps, fl32
[0x7fd5300031d8] scaletempo audio filter debug: params: 30 stride,
0.200 overlap, 14 search
[0x7fd5300031d8] scaletempo audio filter debug: 1.000 scale, 1440.000
stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search,
2400 queue, fl32 mode
[0x7fd5300031d8] main audio filter debug: using audio filter module "scaletempo"
[0x254b3c8] main audio output debug: conversion: 'a52 '->'f32l' 48000
Hz->48000 Hz 3F2R/LFE->3F2R/LFE
[0x7fd5300188e8] main audio converter debug: looking for audio
converter module matching "any": 12 candidates
[0x7fd5300188e8] main audio converter debug: no audio converter modules matched
[0x7fd5300188e8] main audio converter debug: looking for audio
converter module matching "any": 12 candidates
[0x7fd5300188e8] main audio converter debug: using audio converter
module "a52tofloat32"
[0x254b3c8] main audio output debug: conversion pipeline complete
[0x254b3c8] main audio output debug: conversion: 'f32l'->'f32l' 48000
Hz->48000 Hz 3F2R/LFE->3F2R/LFE
[0x254b3c8] main audio output debug: conversion pipeline complete
[0x7fd530023cc8] main audio resampler debug: looking for audio
resampler module matching "any": 3 candidates
[0x7fd530023cc8] main audio resampler debug: using audio resampler
module "samplerate"
[0x7fd550d89848] main decoder debug: End of audio preroll
[0x7fd540001248] main vout display debug: auto hiding mouse cursor
[0x7fd56cc0fd98] main input debug: Decoder buffering done in 1942 ms
[0x254b3c8] pulse audio output debug: cannot synchronize start
[0x254b3c8] pulse audio output warning: starting late (-18188 us)
[0x254b3c8] main audio output warning: playback too late (61226): up-sampling
[0x254b3c8] pulse audio output debug: started
[0x254b3c8] pulse audio output debug: underflow
[0x254b3c8] pulse audio output debug: changing sink 0:
alsa_output.pci-0000_00_1b.0.analog-stereo (Built-in Audio Analog
Stereo)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 4 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 10 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 18 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 1 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 2 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 7 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 4 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 4 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 4 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 5 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 5 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 6 ms)
[0x7fd54401b518] main video output warning: picture is too late to be
displayed (missing 122 ms)
[0x7fd54401b518] main video output warning: picture is too late to be
displayed (missing 120 ms)
[0x7fd54401b518] main video output warning: picture is too late to be
displayed (missing 79 ms)
[0x7fd54401b518] main video output warning: picture is too late to be
displayed (missing 37 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 9 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 2 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 3 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 6 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 7 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 8 ms)
[0x7fd54401b518] main video output debug: picture might be displayed
late (missing 8 ms)
[0x254b3c8] pulse audio output debug: changing sink 0:
alsa_output.pci-0000_00_1b.0.analog-stereo (Built-in Audio Analog
Stereo)

What I don't understand it both the times when it's happening randomly
as well as when I fast-forward why isn't the audio able to reconnect
with the video.  This happens in some media files, not all.

Looking forward to know more. If needed can share the properties of
the media file (without disclosing the media file itself) via
mediainfo if that helps to shed some light as an example. This one was
an .mkv but there have been other formats as well.

Till l8er.
-- 
          Regards,
          Shirish Agarwal  शिरीष अग्रवाल
  My quotes in this email licensed under CC 3.0
http://creativecommons.org/licenses/by-nc/3.0/
http://flossexperiences.wordpress.com
065C 6D79 A68C E7EA 52B3  8D70 950D 53FB 729A 8B17