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?
