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?