[alsa-devel] Facing issues in a2dp sink profile support on linux

jags gediya jags.gediya at gmail.com
Thu Mar 5 11:11:37 CET 2015


Below is the detail of my software SDK:

Kernel version : 3.10.17
Build tool : Yocto
Processor : i.MX6 Sololite
Pulseaudio version : 5.0
Bluez version : 4.101

I want to play music from my phone to the linux box running the above
described setup.
When i play song from the mobile, I am seeing the ACL data through
hcidump. but it is not playing on the headphone.
In the pulseaudio logs, i am seeing the errors.


Below are my changes, for pulseaudio and bluetooth.

/etc/pulse/daemon.conf

resample-method = trivial
enable-remixing = no
enable-lfe-remixing = no
default-sample-format = s16le
default-sample-rate = 48000
alternate-sample-rate = 24000
default-sample-channels = 2

/etc/pulse/system.pa

.ifexists module-bluetooth-policy.so
load-module module-bluetooth-policy
.endif


.ifexists module-bluetooth-discover.so
load-module module-bluetooth-discover
.endif

Below are my steps to connect to mobile.

pulseaudio --system --realtime -vvvvv --log-time=1 --log-target=file:pulse.log &
ADAPTER=`dbus-send --print-reply --system --dest=org.bluez /
org.bluez.Manager.DefaultAdapter | cut -d'"' -f 2 | grep org`
DEVICE_PATH=`dbus-send --system --dest=org.bluez --print-reply
$ADAPTER org.bluez.Adapter.ListDevices | grep path | cut -d'"' -f 2`
dbus-send --print-reply --system --dest=org.bluez $DEVICE_PATH
org.bluez.AudioSource.Connect

in, "pactl modules list short"
I am seeing,
module-bluetooth-device address="00:73:8D:35:2A:B8"
path="/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8"
module-loopback source="bluez_source.00_73_8D_35_2A_B8"
source_dont_move="true" sink_input_properties="media.role=music"

pactl list sources short

bluez_source.00_73_8D_35_2A_B8  module-bluetooth-device.c       s16le
2ch 44100Hz       SUSPENDED


this is the logs, i am getting.


D (   1.163|   0.002)  [pulseaudio] alsa-sink.c: Read hardware volume:
0:  75% 1:  75%
D (   1.163|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Thread
starting up
D (   1.164|   0.000)  [alsa-sink-HiFi sgtl5000-0] core-util.c:
SCHED_RR|SCHED_RESET_ON_FORK worked.
I (   1.164|   0.000)  [alsa-sink-HiFi sgtl5000-0] core-util.c:
Successfully enabled SCHED_RR scheduling for thread, with priority 5.
I (   1.165|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Starting playback.
D (   1.165|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D (   1.165|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D (   1.166|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D (   1.166|   0.000)  [pulseaudio] alsa-util.c: Trying front:0 with
SND_PCM_NO_AUTO_FORMAT ...
I (   1.167|   0.000)  [pulseaudio] conf.c: Unknown parameters 0
I (   1.167|   0.000)  [pulseaudio] pcm.c: Unknown PCM front:0
I (   1.167|   0.000)  [pulseaudio] alsa-util.c: Error opening PCM
device front:0: Invalid argument
D (   1.167|   0.000)  [pulseaudio] alsa-util.c: Trying hw:0 with
SND_PCM_NO_AUTO_FORMAT ...
D (   1.169|   0.001)  [pulseaudio] alsa-util.c: Managed to open hw:0
I (   1.169|   0.000)  [pulseaudio] alsa-util.c: cannot disable ALSA
period wakeups
D (   1.169|   0.000)  [pulseaudio] alsa-util.c: Maximum hw buffer
size is 371 ms
D (   1.174|   0.005)  [pulseaudio] alsa-util.c: Set buffer size first
(to 88200 samples), period size second (to 88200 samples).
I (   1.175|   0.000)  [pulseaudio] alsa-util.c: ALSA period wakeups
were not disabled
I (   1.175|   0.000)  [pulseaudio] alsa-source.c: Successfully opened
device hw:0.
I (   1.175|   0.000)  [pulseaudio] alsa-source.c: Selected mapping
'Analog Stereo' (analog-stereo).
I (   1.175|   0.000)  [pulseaudio] alsa-source.c: Successfully
enabled mmap() mode.
I (   1.175|   0.000)  [pulseaudio] alsa-source.c: Successfully
enabled timer-based scheduling mode.
I (   1.177|   0.001)  [pulseaudio] alsa-util.c: Successfully attached
to mixer 'hw:0'
D (   1.179|   0.002)  [pulseaudio] alsa-mixer.c: Added 1 ports
I (   1.180|   0.000)  [pulseaudio] source.c: Created source 1
"alsa_input.platform-sound.25.analog-stereo" with sample spec s16le
2ch 44100Hz and channel map front-left,front-right
.
.
.
.
I (   1.194|   0.000)  [pulseaudio] module.c: Loaded
"module-alsa-card" (index: #0; argument: "device_id="0"
name="platform-sound.25" card_name="alsa_card.platform-sound.25"
namereg_fail=false tsched=yes fixed_latency_range=no ignore_dB=no
deferred_volume=yes use_ucm=yes
card_properties="module-udev-detect.discovered=1"").
I (   1.194|   0.000)  [pulseaudio] module-udev-detect.c: Card
/devices/soc0/sound.25/sound/card0 (alsa_card.platform-sound.25)
module loaded.
I (   1.194|   0.000)  [pulseaudio] module-udev-detect.c: Found 1 cards.
I (   1.194|   0.000)  [pulseaudio] module.c: Loaded
"module-udev-detect" (index: #1; argument: "").
D (   1.195|   0.000)  [pulseaudio] cli-command.c: Checking for
existence of '/usr/lib/pulse-4.0/modules/module-esound-protocol-unix.so':
failure
W (   1.212|   0.016)  [pulseaudio] authkey.c: Failed to open cookie
file '/var/run/pulse/.config/pulse/cookie': No such file or directory
W (   1.212|   0.000)  [pulseaudio] authkey.c: Failed to load
authorization key '/var/run/pulse/.config/pulse/cookie': No such file
or directory
W (   1.212|   0.000)  [pulseaudio] authkey.c: Failed to open cookie
file '/var/run/pulse/.pulse-cookie': No such file or directory
W (   1.212|   0.000)  [pulseaudio] authkey.c: Failed to load
authorization key '/var/run/pulse/.pulse-cookie': No such file or
directory
D (   1.213|   0.000)  [pulseaudio] authkey.c: Got 0 bytes from cookie
file '/var/run/pulse/.config/pulse/cookie', expected 256
I (   1.214|   0.001)  [pulseaudio] module.c: Loaded
"module-native-protocol-unix" (index: #2; argument:
"auth-anonymous=1").
I (   1.228|   0.013)  [pulseaudio] module-stream-restore.c:
Successfully opened database file
'/var/lib/pulse/79e7ab36632556972e086ba654e49e31-stream-volumes'.
.
.
.
.
D ( 107.002|  34.839)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.AudioSource,
path=/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8, member=PropertyChanged
D ( 107.003|   0.000)  [pulseaudio] bluetooth-util.c: Device
/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8 interface
org.bluez.AudioSource property 'State' changed to value 'connecting'
D ( 107.363|   0.360)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.Device,
path=/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8, member=PropertyChanged
D ( 107.496|   0.132)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.MediaEndpoint, path=/MediaEndpoint/A2DPSink,
member=SelectConfiguration
D ( 107.496|   0.000)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.MediaEndpoint, path=/MediaEndpoint/A2DPSink,
member=SelectConfiguration
D ( 107.510|   0.013)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.MediaEndpoint, path=/MediaEndpoint/A2DPSink,
member=SetConfiguration
D ( 107.510|   0.000)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.MediaEndpoint, path=/MediaEndpoint/A2DPSink,
member=SetConfiguration
D ( 107.510|   0.000)  [pulseaudio] bluetooth-util.c: Transport
/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8/fd0 profile 1 available
D ( 107.567|   0.056)  [pulseaudio] bluetooth-util.c: dbus:
interface=org.bluez.AudioSource,
path=/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8, member=PropertyChanged
D ( 107.567|   0.000)  [pulseaudio] bluetooth-util.c: Device
/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8 interface
org.bluez.AudioSource property 'State' changed to value 'connected'
D ( 107.567|   0.000)  [pulseaudio] bluetooth-util.c: Transport
/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8/fd0 (profile a2dp_source)
changed state from disconnected to idle.
D ( 107.567|   0.000)  [pulseaudio] module-bluetooth-discover.c:
Loading module-bluetooth-device address="00:73:8D:35:2A:B8"
path="/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8"
I ( 107.594|   0.027)  [pulseaudio] card.c: Created 1
"bluez_card.00_73_8D_35_2A_B8"
W ( 107.595|   0.000)  [pulseaudio] module-bluetooth-device.c: Default
profile not connected, selecting off profile
I ( 107.595|   0.000)  [pulseaudio] module.c: Loaded
"module-bluetooth-device" (index: #13; argument:
"address="00:73:8D:35:2A:B8"
path="/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8"").
.
.
.
.
D ( 195.725|   0.003)  [pulseaudio] module-bluetooth-device.c:
Acquiring transport /org/bluez/351/hci0/dev_00_73_8D_35_2A_B8/fd0
I ( 195.725|   0.000)  [pulseaudio] bluetooth-util.c: Failed optional
acquire of transport /org/bluez/351/hci0/dev_00_73_8D_35_2A_B8/fd0
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c: Failed
optional acquire of transport
/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8/fd0
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c: SBC parameters:
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c:  allocation=0
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c:  subbands=1
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c:  blocks=3
I ( 195.725|   0.000)  [pulseaudio] module-bluetooth-device.c:  bitpool=19
D ( 195.726|   0.000)  [pulseaudio] module-device-restore.c: Database
contains invalid data for key:
source:bluez_source.00_73_8D_35_2A_B8:null
I ( 195.726|   0.000)  [pulseaudio] source.c: Created source 2
"bluez_source.00_73_8D_35_2A_B8" with sample spec s16le 2ch 44100Hz
and channel map front-left,front-right
I ( 195.726|   0.000)  [pulseaudio] source.c:     bluetooth.protocol =
"a2dp_source"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.description =
"jags gediya"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.string =
"00:73:8D:35:2A:B8"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.api = "bluez"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.class = "sound"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.bus = "bluetooth"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.form_factor = "phone"
I ( 195.726|   0.000)  [pulseaudio] source.c:     bluez.path =
"/org/bluez/351/hci0/dev_00_73_8D_35_2A_B8"
I ( 195.726|   0.000)  [pulseaudio] source.c:     bluez.class = "0x5a020c"
I ( 195.726|   0.000)  [pulseaudio] source.c:     bluez.name = "jags gediya"
I ( 195.726|   0.000)  [pulseaudio] source.c:     device.icon_name =
"audio-card-bluetooth"
D ( 195.728|   0.001)  [bluetooth] module-bluetooth-device.c: IO
Thread starting up
D ( 195.728|   0.000)  [bluetooth] core-util.c:
SCHED_RR|SCHED_RESET_ON_FORK worked.
I ( 195.728|   0.000)  [bluetooth] core-util.c: Successfully enabled
SCHED_RR scheduling for thread, with priority 5.
D ( 195.729|   0.000)  [pulseaudio] module-suspend-on-idle.c: Source
bluez_source.00_73_8D_35_2A_B8 becomes idle, timeout in 5 seconds.
D ( 195.747|   0.018)  [pulseaudio] module-suspend-on-idle.c: Sink
alsa_output.platform-sound.25.analog-stereo becomes busy, resuming.
D ( 195.747|   0.000)  [pulseaudio] sink.c: Suspend cause of sink
alsa_output.platform-sound.25.analog-stereo is 0x0000, resuming
I ( 195.747|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Trying resume...
I ( 195.749|   0.001)  [alsa-sink-HiFi sgtl5000-0] alsa-util.c: cannot
disable ALSA period wakeups
D ( 195.749|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-util.c:
Maximum hw buffer size is 371 ms
D ( 195.757|   0.007)  [alsa-sink-HiFi sgtl5000-0] alsa-util.c: Set
buffer size first (to 16384 samples), period size second (to 8192
samples).
I ( 195.758|   0.001)  [alsa-sink-HiFi sgtl5000-0] alsa-util.c: ALSA
period wakeups were not disabled
D ( 195.758|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: hwbuf_unused=0
D ( 195.758|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
setting avail_min=15502
I ( 195.759|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Time
scheduling watermark is 20.00ms
I ( 195.759|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Resumed successfully....
.
.
.
I ( 195.773|   0.000)  [pulseaudio] protocol-native.c: Connection died.
D ( 195.945|   0.172)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
I ( 195.945|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Underrun!
I ( 195.945|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 30.00 ms
D ( 196.131|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
I ( 196.131|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Underrun!
I ( 196.131|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 40.00 ms
D ( 196.316|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
I ( 196.317|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 50.00 ms
I ( 196.502|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 56.64 ms
I ( 196.688|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing minimal latency to 1.00 ms
D ( 196.688|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Latency set to 66.67ms
D ( 196.688|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
hwbuf_unused=53780
D ( 196.688|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
setting avail_min=13888
D ( 196.689|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Latency set to 66.67ms
D ( 196.689|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
hwbuf_unused=53780
D ( 196.689|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
setting avail_min=13888
I ( 196.874|   0.184)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing minimal latency to 2.00 ms
D ( 196.874|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Latency set to 66.67ms
D ( 196.874|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
hwbuf_unused=53780
D ( 196.874|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
setting avail_min=13888
.
.
D ( 304.751|   0.000)  [alsa-sink-HiFi sgtl5000-0] ratelimit.c: 47
events suppressed
D ( 304.751|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.751|   0.000)  [pulseaudio] module-suspend-on-idle.c: Source
bluez_source.00_73_8D_35_2A_B8 becomes busy, resuming.
D ( 304.751|   0.000)  [pulseaudio] core-subscribe.c: Dropped
redundant event due to change event.
D ( 304.752|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.752|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.753|   0.001)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.753|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.754|   0.000)  [pulseaudio] module-loopback.c: Loopback
overall latency is 63.82 ms + 0.00 ms + 74.89 ms = 138.70 ms
D ( 304.754|   0.000)  [pulseaudio] module-loopback.c: Should buffer
23512 bytes, buffered at minimum 0 bytes
I ( 304.754|   0.000)  [pulseaudio] module-loopback.c: New rate of
43513 Hz not within 2‰ of 44100 Hz, forcing smaller adjustment
D ( 304.754|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.759|   0.005)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.760|   0.000)  [pulseaudio] module-loopback.c:
[alsa_output.platform-sound.25.analog-stereo] Updated sampling rate to
44011 Hz.
D ( 304.760|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.760|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.760|   0.000)  [pulseaudio] module-loopback.c: Loopback
overall latency is 56.99 ms + 0.00 ms + 81.77 ms = 138.76 ms
D ( 304.761|   0.000)  [pulseaudio] module-loopback.c: Should buffer
23472 bytes, buffered at minimum 0 bytes
I ( 304.761|   0.000)  [pulseaudio] module-loopback.c: New rate of
43514 Hz not within 2‰ of 44011 Hz, forcing smaller adjustment
D ( 304.761|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.764|   0.002)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Cutting sleep time for the initial iterations by half.
D ( 304.764|   0.000)  [pulseaudio] core-subscribe.c: Dropped
redundant event due to change event.
D ( 304.764|   0.000)  [pulseaudio] module-loopback.c:
[alsa_output.platform-sound.25.analog-stereo] Updated sampling rate to
43922 Hz.
D ( 304.915|   0.150)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
D ( 304.922|   0.007)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
D ( 304.925|   0.002)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
I ( 304.936|   0.011)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 30.00 ms
I ( 304.955|   0.018)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Could not peek into queue
D ( 304.955|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.966|   0.011)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.966|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.971|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
    D ( 304.973|   0.002)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
    D ( 304.976|   0.002)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.976|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.979|   0.003)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.980|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 304.998|   0.018)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.017|   0.018)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.021|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.021|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.026|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.026|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.031|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.031|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.036|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.036|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.055|   0.018)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.074|   0.018)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.080|   0.006)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.081|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.086|   0.005)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.086|   0.000)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
D ( 305.086|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.092|   0.005)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.092|   0.000)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
D ( 305.092|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.095|   0.003)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.095|   0.000)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Requesting rewind due to end of underrun.
D ( 305.095|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
D ( 305.114|   0.018)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1920 bytes ago (9836 bytes ahead in playback buffer)
I ( 305.122|   0.007)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c:
Increasing wakeup watermark to 40.00 ms
I ( 305.129|   0.007)  [alsa-sink-HiFi sgtl5000-0] module-loopback.c:
Could not peek into queue
D ( 305.129|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.140|   0.010)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.140|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.144|   0.003)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.144|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.148|   0.003)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.148|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.152|   0.003)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.152|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.179|   0.026)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.196|   0.017)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.197|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.202|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.202|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.207|   0.005)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.207|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.212|   0.004)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.212|   0.000)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.239|   0.026)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
D ( 305.254|   0.015)  [alsa-sink-HiFi sgtl5000-0] sink.c: Found
underrun 1924 bytes ago (9832 bytes ahead in playback buffer)
.
.
I ( 312.115|   0.000)  [pulseaudio] protocol-native.c: Connection died.
D ( 314.782|   2.666)  [alsa-sink-HiFi sgtl5000-0] ratelimit.c: 27
events suppressed
D ( 314.782|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 314.967|   0.184)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 315.153|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 315.339|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 315.525|   0.186)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 315.711|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 315.896|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 316.082|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 316.268|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 316.454|   0.186)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 316.641|   0.187)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 319.797|   3.155)  [alsa-sink-HiFi sgtl5000-0] ratelimit.c: 16
events suppressed
D ( 319.797|   0.000)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 319.983|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 320.172|   0.188)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 320.354|   0.182)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 320.540|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 320.726|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 320.912|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 321.097|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 321.284|   0.187)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 321.469|   0.184)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
D ( 321.655|   0.185)  [alsa-sink-HiFi sgtl5000-0] alsa-sink.c: Wakeup
from ALSA!
.
.
.
D ( 381.721|   0.066)  [pulseaudio] module-loopback.c: Loopback
overall latency is 0.00 ms + 1412.45 ms + 62.23 ms = 1474.68 ms
D ( 381.721|   0.000)  [pulseaudio] module-loopback.c: Should buffer
64888 bytes, buffered at minimum 210984 bytes
I ( 381.721|   0.000)  [pulseaudio] module-loopback.c: New rate of
47752 Hz not within 2‰ of 43608 Hz, forcing smaller adjustment
D ( 381.722|   0.000)  [pulseaudio] module-loopback.c:
[alsa_output.platform-sound.25.analog-stereo] Updated sampling rate to
43695 Hz.

>From the logs, what can be the issue?


More information about the Alsa-devel mailing list