# Troubleshoot audio

Debug audio problems by capturing logs and matching the log output to
each stage of a playback or record use case. Start by capturing user
space and kernel logs, then analyze the log snippets to confirm the
stream, backend, metadata, and graph for the use case.

## Capture logs

Capture user space and kernel audio driver logs and analyze them to
debug playback and record issues.

Use the following command to capture use rspace logs:

journalctl -f
    Copy to clipboard

Use the following command to capture kernel logs

$ dmesg
    Copy to clipboard

## Analyze audio playback logs

Analyze user space and kernel audio driver logs to debug the playback
use case.

The following log snippet shows the information collected for
the playback use case, including the stream open, backend media
configuration, metadata, graph open, hardware endpoint configuration,
and stream stop and close.

// Pal stream open for Low latency Playback.
    Jul 14 12:15:17 debian pipewire[1498]: pal_stream_open: 277: Enter, stream type:1
    Jul 14 12:15:17 debian pipewire[1498]: init: 1414: XML parsing started /etc/usecaseKvManager.xml
    
    //Verify Playback Device
    Jul 14 12:15:17 debian pipewire[1498]: open: 301: Enter. deviceCount 0
    for device id 3 (PAL_DEVICE_OUT_SPEAKER)
    
    //Verify the backend device, sample rate, bitwidth, channels etc.
    Jul 14 12:15:17 debian pipewire[1498]: setMediaConfig: 1068: CODEC_DMA-LPAIF_WSA-RX-0 rate ch fmt data_fmt 48000 4 2 1
    
    //Start playback stream
    Jul 14 12:15:17 debian pipewire[1498]: pal_stream_start: 422: Enter. Stream handle
    0xaaaae280c860K
    
    //Graph open call
    Jul 14 12:15:17 debian pipewire[1498]: graph_open: 526 entry
    
    //Map the metadata with kvh2xml.h file for playback use case details.
    Jul 14 12:15:17 debian pipewire[1498]: metadata_print: 82 key:0xa1000000, value:0xa100000e  //PCM_LL_PLAYBACK
    Jul 14 12:15:17 debian pipewire[1498]: metadata_print: 82 key:0xab000000, value:0x1
    Jul 14 12:15:17 debian pipewire[1498]: metadata_print: 82 key:0xa2000000, value:0xa2000001 //Speaker
    Jul 14 12:15:17 debian pipewire[1498]: metadata_print: 82 key:0xac000000, value:0xac000002 //DEVICEPP_RX_AUDIO_MBDRC
    
    //Verify the graph opened for playback use case
    Jul 14 12:15:17 debian pipewire[1498]: print_graph_alias: 2326 GKV Alias 2 | StreamRX_PCM_LL_Playback_DeviceRX_Speaker_Instance_Instance_1_DevicePP_Rx_Audio_MBDRC
    Jul 14 12:15:17 debian pipewire[1498]: graph_open: 724 exit, ret 0
    Jul 14 12:15:17 debian pipewire[1498]: graph_prepare: 788 entry graph_handle 0x47534c
    
    //Configure hardware endpoint module
    Jul 14 12:15:17 debian pipewire[1498]: configure_hw_ep_media_config: 877 entry mod tag c0000004 miid 415d mid 7001023
    Jul 14 12:15:17 debian pipewire[1498]: configure_hw_ep_media_config: 905 rate 48000 bw 16 ch 4, data_fmt 1
    Jul 14 12:15:17 debian pipewire[1498]: configure_hw_ep_media_config: 939 exit, ret 0
    Jul 14 12:15:17 debian pipewire[1498]: configure_codec_dma_ep: 307 entry mod tag c0000004 miid 415d mid 7001023
    Jul 14 12:15:17 debian pipewire[1498]: graph_prepare: 866 exit, ret 0
    //Graph start
    Jul 14 12:15:17 debian pipewire[1498]: graph_start: 880 entry graph_handle 0x47534c
    Jul 14 12:15:17 debian pipewire[1498]: graph_start: 895 exit, ret 0
    //pal_stream_stop
    Jul 14 12:15:47 debian pipewire[1498]: pal_stream_stop: 524: Enter. Stream handle :0xaaaae280c860K
    Jul 14 12:15:47 debian pipewire[1498]: graph_stop: 911 entry graph_handle 0x47534c
    Jul 14 12:15:47 debian pipewire[1498]: graph_stop: 961 exit, ret 0
    Jul 14 12:15:47 debian pipewire[1498]: pal_stream_stop: 590: Exit. status 0
    //pal_stream_close
    Jul 14 12:15:47 debian pipewire[1498]: pal_stream_close: 346: Enter. Stream handle :0xaaaae280c860K
    Jul 14 12:15:47 debian pipewire[1498]: session_close: 1336 enter
    Jul 14 12:15:47 debian pipewire[1498]: graph_close: 741 entry handle 0x47534c
    Jul 14 12:15:47 debian pipewire[1498]: graph_close: 764 exit, ret 0
    Jul 14 12:15:47 debian pipewire[1498]: session_close: 1388 exit, ret 0
    Jul 14 12:15:47 debian pipewire[1498]: pal_stream_close: 398: Exit. status 0
    Copy to clipboard

## Analyze audio record logs

Analyze user space and kernel audio driver logs to
debug the record use case.
The following backend media configuration,
graph open, metadata, hardware endpoint configuration, and log snippet
shows the information collected for the record use case, including the
stream open, stream stop and close.

//Open Recording stream for PAL_STREAM_DEEP_BUFFER
    Aug 13 17:17:01 debian pipewire[1795]: pal_stream_open: 277: Enter, stream type:2
    Aug 13 17:17:01 debian pipewire[1795]: pcm_plug_open: dlopen successful for libagm_pcm_plugin.so Aug 13 17:17:01 debian pipewire[1795]: SessionAR:  58: usecase manager xml parsing successful
    
    //Device used for recording
    Aug 13 17:17:01 debian pipewire[1795]: open: 301: Enter. deviceCount 0 for device id 32 (PAL_DEVICE_IN_SPEAKER_MIC)
    Aug 13 17:17:01 debian pipewire[1795]: setMediaConfig: 1068: CODEC_DMA-LPAIF_VA-TX-0 rate ch fmt data_fmt 48000 1 2 1
    Aug 13 17:17:01 debian pipewire[1795]: pal_stream_open: 324: Exit. Value of stream_handle 0xaaaaf31a6f20K, status 0
    Aug 13 17:17:01 debian pipewire[1795]: pal_stream_start: 422: Enter. Stream handle 0xaaaaf31a6f20K
    
    //Backend device, sample rate, bitwidth, channels used for recording
    Aug 13 17:17:01 debian pipewire[1795]: setMediaConfig: 1068: CODEC_DMA-LPAIF_VA-TX-0 rate ch fmt data_fmt 48000 1 2 1
    
    //Graph open
    Aug 13 17:17:01 debian pipewire[1795]: graph_open: 526 entry
    
    //Metadata details to identify the use case
    Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 79
    *****Metadata*****
    Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 80 GKV size:4 Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 82 key:0xb1000000, value:0xb1000001 //PCM_RECORD
    Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 82 key:0xab000000, value:0x1
    Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 82 key:0xa3000000, value:0xa3000001 //SPEAKER_MIC Aug 13 17:17:01 debian pipewire[1795]: metadata_print: 82 key:0xad000000, value:0xad000002 //DEVICEPP_TX_AUDIO_FLUENCE_SMECNS
    
    //Verify the graph opened for recording use case
    Aug 13 17:17:01 debian pipewire[1795]: print_graph_alias: 2326 GKV Alias 3 | DeviceTX_Speaker_Mic_Instance_Instance_1_DevicePP_Tx_Audio_Fluence_SMECNS_StreamTX_PCM_Record
    Aug 13 17:17:01 debian pipewire[1795]: graph_open: 688 graph_handle 0x47534c
    Aug 13 17:17:01 debian pipewire[1795]: graph_open: 724 exit, ret 0 Aug 13 17:17:01 debian pipewire[1795]: graph_prepare: 788 entry graph_handle 0x47534c
    
    //Configure hardware endpoint module
    Aug 13 17:17:01 debian pipewire[1795]: configure_hw_ep_media_config: 877 entry mod tag c0000005 miid 415c mid 7001024 Aug 13 17:17:01 debian pipewire[1795]: configure_hw_ep_media_config: 905 rate 48000 bw 16 ch 1, data_fmt 1
    Aug 13 17:17:01 debian pipewire[1795]: configure_hw_ep_media_config: 939 exit, ret 0
    Aug 13 17:17:01 debian pipewire[1795]: graph_prepare: 866 exit, ret 0
    
    //graph_start
    Aug 13 17:17:01 debian pipewire[1795]: graph_start: 880 entry graph_handle 0x47534c
    Aug 13 17:17:01 debian pipewire[1795]: graph_start: 895 exit, ret 0
    
    //Stream recording started
    Aug 13 17:17:01 debian pipewire[1795]: pal_stream_start: 499: Exit. status 0 type 2 stream_handle 0xaaaaf31a6f20K
    Aug 13 17:17:36 debian pipewire[1795]: pal_stream_stop: 524: Enter. Stream handle :0xaaaaf31a6f20K
    Aug 13 17:17:36 debian pipewire[1795]: stop: 718: In PAL_AUDIO_INPUT case, device count - 1
    Aug 13 17:17:36 debian pipewire[1795]: graph_stop: 911 entry graph_handle 0x47534c
    Aug 13 17:17:36 debian pipewire[1795]: graph_stop: 961 exit, ret 0
    
    //Recording stream stop
    Aug 13 17:17:36 debian pipewire[1795]: pal_stream_stop: 590: Exit. status 0
    
    //PAL stream close
    Aug 13 17:17:36 debian pipewire[1795]: pal_stream_close: 346: Enter. Stream handle :0xaaaaf31a6f20K
    Aug 13 17:17:36 debian pipewire[1795]: session_close: 1337 enter
    Aug 13 17:17:36 debian pipewire[1795]: graph_close: 741 entry handle 0x47534c
    Aug 13 17:17:36 debian pipewire[1795]: graph_close: 764 exit, ret 0
    Aug 13 17:17:36 debian pipewire[1795]: session_close: 1389 exit, ret 0
    Aug 13 17:17:36 debian pipewire[1795]: close: 375: Exit. deviceCount 0 for device id 32 (PAL_DEVICE_IN_SPEAKER_MIC), exit status 0
    Copy to clipboard

Last Published: Sep 08, 2026

[Previous Topic
Customize audio use cases](https://docs.qualcomm.com/bundle/publicresource/80-A0399-50/topics/customize.md) [Next Topic
References](https://docs.qualcomm.com/bundle/publicresource/80-A0399-50/topics/references.md)