# Debug

This section provides information about audio-specific logging and
debugging.

## Capture logs

User space and kernel audio driver logs can be used to identify issues.

| **User space logs** | To capture user space logs:<br><br><br>ssh root@ip-addr<br>    mount -o remount,rw /<br>    cat /var/log/user.log<br>    Copy to clipboard<br><br><br>See [User space<br>logs](https://docs.qualcomm.com/bundle/publicresource/topics/80-70015-12/using_open_source_debug_tools.html#user_space_logs)<br>for detailed instructions. |
| --- | --- |
| **Kernel audio driver logs** | To capture kernel logs:<br><br><br>ssh root@ip-addr dmesg<br>    Copy to clipboard<br><br><br>To disable kernel logs in a specific file:<br><br><br>echo –n “file <filename> -p” > /sys/kernel/debug/dynamic_debug/control<br>    Copy to clipboard |
| **Dynamic kernel logs** | Dynamic logging is disabled by default. To enable it, add the<br>`CONFIG_DYNAMIC_DEBUG` kernel configuration, recompile, and<br>re-flash the device.<br><br><br>To enable audio dynamic kernel logs:<br><br><br>ssh root@ip-addr<br>    mount -o rw,remount /<br>    mount -t debugfs none /sys/kernel/debug<br>    echo –n “file <filename> +p” > /sys/kernel/debug/dynamic_debug/control<br>    Copy to clipboard<br><br><br>See [Enable dynamic<br>debug](https://docs.qualcomm.com/bundle/publicresource/topics/80-70015-12/debugging_linux_kernel.html#enable_dynamic_debug)<br>for detailed instructions. |

## Analyze collected logs

Review user space and kernel audio driver logs for playback and record
use cases.

### Playback

The following log snippet describes the information collected for the
playback use case.

//Open Low latency Playback stream. Details of each stream type can be found at sources/audio/opensource/arpal-lx/inc/PalDefs.h
    2022-04-28T18:02:08.748280+00:00 pulseaudio: pal_stream_open: 224: Enter, stream type:1
    
    //Verify the backend device, sample rate, bitwidth, channels etc
    2022-04-28T18:02:08.748627+00:00 pulseaudio: setDeviceMediaConfig: 1056: CODEC_DMA-LPAIF_WSA-RX-0 rate ch fmt data_fmt 48000 2 2 1
    
    //Start playback stream
    2022-04-28T18:02:08.751947+00:00 pulseaudio: pal_stream_start: 338: Enter. Stream handle 0xffff94001040K
    
    //Map the metadata with kvh2xml.h file for playback usecase details.
    2022-04-28T18:02:08.853157+00:00 pulseaudio: metadata_print: 82 key:0xa1000000, value:0xa100000e//PCM_LL_PLAYBACK
    2022-04-28T18:02:08.853395+00:00 pulseaudio: metadata_print: 82 key:0xab000000, value:0x1
    2022-04-28T18:02:08.853660+00:00 pulseaudio: metadata_print: 82 key:0xa2000000, value:0xa2000001//Speaker
    2022-04-28T18:02:08.853881+00:00 pulseaudio: metadata_print: 82 key:0xac000000, value:0xac000002//DEVICEPP_RX_AUDIO_MBDRC
    
    //Verify the graph opened for playback usecase
    2022-04-28T18:02:08.856934+00:00 pulseaudio: print_graph_alias: 2334 GKV Alias 142 | StreamRX_PCM_LL_Playback_DeviceRX_Speaker_Instance_Instance_1_DevicePP_Rx_Audio_MBDRC
    //graph_open called
    2022-04-28T18:02:08.859509+00:00 pulseaudio: graph_open: 709 graph_handle 0x47534c
    
    //Configure hardware endpoint module
    2022-04-28T18:02:08.864386+00:00 pulseaudio: configure_hw_ep_media_config: 636 entry mod tag c0000004 miid 43b1 mid 7001023
    2022-04-28T18:02:08.864495+00:00 pulseaudio: configure_hw_ep_media_config: 664 rate 48000 bw 16 ch 2, data_fmt 1
    2022-04-28T18:02:08.864603+00:00 pulseaudio: configure_hw_ep_media_config: 676 exit, ret 0
    
    //graph_start entry
    2022-04-28T18:02:08.867234+00:00 pulseaudio: graph_start: 899 entry graph_handle 0x47534c
    //Stream started
    2022-04-28T18:02:08.867864+00:00 pulseaudio: pal_stream_start: 387: Exit. status 0
    
    //graph_stop entry
    2022-04-28T18:02:25.037338+00:00 pulseaudio: graph_stop: 928 entry graph_handle 0x47534c
    //Stop the PAL stream once playback completes
    2022-04-28T18:02:25.039923+00:00 pulseaudio: pal_stream_stop: 441: Exit. status 0
    
    //graph_close entry
    2022-04-28T18:02:25.050944+00:00 pulseaudio: graph_close: 762 entry handle 0x47534c
    //Close the PAL stream
    2022-04-28T18:02:25.054510+00:00 pulseaudio: pal_stream_close: 322: Exit. status 0
    Copy to clipboard

### Record

The following log snippet describes the information collected for the
record use case.

//Open Recording stream for PAL_STREAM_RAW. Details of stream type can be found at sources/audio/opensource/arpal-lx/inc/PalDefs.h
    Apr 29 09:23:11 pulseaudio[862]: pal_stream_open: 224: Enter, stream type:9
    
    //Verify the backend device, sample rate, bitwidth, channels etc
    Apr 29 09:23:11 pulseaudio[862]: setDeviceMediaConfig: 1056: CODEC_DMA-LPAIF_VA-TX-0 rate ch fmt data_fmt 48000 1 2 1
    
    //Start recording stream
    Apr 29 09:23:11 pulseaudio[862]: pal_stream_start: 338: Enter. Stream handle 0xffff6c001040K
    
    //graph_open entry
    Apr 29 09:23:11 pulseaudio[862]: graph_open: 709 graph_handle 0x47534c
    
    //Metadata details to identify the usecase
    Apr 29 09:23:11 pulseaudio[862]: metadata_print: 82 key:0xb1000000, value:0xb1000009//RAW_RECORD
    Apr 29 09:23:11 pulseaudio[862]: metadata_print: 82 key:0xa3000000, value:0xa3000004//HANDSETMIC
    
    //Verify the graph opened for recording usecase
    Apr 29 09:23:11 pulseaudio[862]: print_graph_alias: 2334 GKV Alias 29 | DeviceTX_Handset_Mic_StreamTX_RAW_Record
    
    //Configure hardware endpoint module
    Apr 29 09:23:11 pulseaudio[862]: configure_hw_ep_media_config: 636 entry mod tag c0000005 miid 43af mid 7001024
    Apr 29 09:23:11 pulseaudio[862]: configure_hw_ep_media_config: 664 rate 48000 bw 16 ch 1, data_fmt 1
    Apr 29 09:23:11 pulseaudio[862]: configure_hw_ep_media_config: 676 exit, ret 0
    
    //graph_start entry
    Apr 29 09:23:11 pulseaudio[862]: graph_start: 899 entry graph_handle 0x47534c
    //Stream recording started
    Apr 29 09:23:11 pulseaudio[862]: pal_stream_start: 387: Exit. status 0

    //graph_stop entry
    Apr 29 09:23:26 pulseaudio[862]: graph_stop: 928 entry graph_handle 0x47534c
    //Stop the PAL stream once user stops recording
    Apr 29 09:23:26 pulseaudio[862]: D: [regular2] pal-source.c: pal_stream_stop returned 0
    
    //Close the PAL stream
    Apr 29 09:23:26 pulseaudio[862]: pal_stream_close: 284: Enter. Stream handle :0xffff6c001040K
    //graph_close entry
    Apr 29 09:23:26 pulseaudio[862]: graph_close: 762 entry handle 0x47534c
    //Close the PAL stream
    Apr 29 09:23:26 pulseaudio[862]: pal_stream_close: 322: Exit. status 0
    Copy to clipboard

Last Published: Oct 15, 2024

[Previous Topic
Customize](https://docs.qualcomm.com/bundle/publicresource/80-70015-16/topics/customize.md) [Next Topic
Detailed Feature Descriptions](https://docs.qualcomm.com/bundle/publicresource/80-70015-16/topics/detailed_feature_description.md)