TIMESTAMP         (us)              DELTA  C# COMPONENT          LOCATION                      CONTENT	ktime=3052.383s  @  2022-07-18 22:23:37 +0000 UTC
[  6100058131.459635] (           0.000000) c0 dma-trace             src/trace/dma-trace.c:347  INFO SHM: FW ABI 0x3017000 DBG ABI 0x5003000 tags SOF:v2.0-rc1-1126-gea72e3e97e10 src hash 0xf4ed17b0 (ldc hash 0xf4ed17b0)
[     1218457.764083] (     1218457.750000) c0 ipc                  src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x60050000
[     1218483.076582] (          25.312498) c0 pipe         10.57 ....../pipeline-stream.c:270  INFO pipe trigger cmd 0
[     1218868.284900] (         385.208313) c0 dmic-dai     2.0   ....../intel/dmic/dmic.c:422  INFO dmic_stop(), dmic_active_fifos_mask = 0x1
[     1218891.201566] (          22.916666) c0 dw-dma                 src/drivers/dw/dma.c:413  INFO dw_dma_stop(): dma 0 channel 0 stop
[     1218923.649481] (          32.447914) c0 ll-schedule        ./schedule/ll_schedule.c:159  INFO task complete 0xbe1e0300 pipe-task <f11818eb-e92e-4082-82a3-dc54c604ebb3>
[     1218941.566147] (          17.916666) c0 ll-schedule        ./schedule/ll_schedule.c:162  INFO num_tasks 2 total_num_tasks 2
[     1219787.139030] (         845.572876) c0 ipc                  src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x60030000
[     1219810.732779] (          23.593750) c0 pipe         10.57 ......./pipeline-graph.c:347  INFO pipe reset
[     1219930.368191] (         119.635414) c0 eq-iir       10.52 ../audio/eq_iir/eq_iir.c:889  INFO eq_iir_reset()
[     1219977.295272] (          46.927082) c0 dai          10.56   src/audio/dai-legacy.c:706  INFO dai_reset()
[     1220003.805688] (          26.510416) c0 dw-dma                 src/drivers/dw/dma.c:260  INFO dw_dma_channel_put(): dma 0 channel 0 put
[     1941325.860359] (      721322.062500) c0 ipc                  src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x60010000
[     1941353.881191] (          28.020832) c0 pipe         10.57 ....../pipeline-params.c:249  INFO pipe params dir 1 frame_fmt 0 buffer_fmt 0 rate 48000
[     1941372.474940] (          18.593750) c0 pipe         10.57 ....../pipeline-params.c:253  INFO pipe params stream_tag 2 channels 4 sample_valid_bytes 2 sample_container_bytes 2
[     1941542.527017] (         170.052078) c0 dai          10.56       src/ipc/ipc3/dai.c:109  INFO dai_data_config() dai type = 2 index = 0 dd 0x9e11e000
[     1941562.787433] (          20.260416) c0 dai          10.56       src/ipc/ipc3/dai.c:133  INFO dai_data_config() burst_elems = 0
[     1941624.349930] (          61.562496) c0 dai          10.56   src/audio/dai-legacy.c:435  INFO dai_capture_params() src_dev = 0 stream_id = 0 src_width = 4 dest_width = 4
[     1941644.297846] (          19.947916) c0 dai          10.56   src/audio/dai-legacy.c:441  INFO dai_capture_params() fifo 0x10008
[     1941673.308262] (          29.010416) c0 pipe         10.57 ....../pipeline-params.c:346  INFO pipe prepare
[     1941756.277008] (          82.968750) c0 dai          10.56   src/audio/dai-legacy.c:655  INFO dai_prepare()
[     1941775.652007] (          19.375000) c0 dai          10.56   src/audio/dai-legacy.c:621  INFO dai_config_prepare(), channel = 0
[     1941793.829090] (          18.177082) c0 dw-dma                 src/drivers/dw/dma.c:194  INFO dw_dma_channel_get(): dma 0 request channel 0
[     1941813.777006] (          19.947916) c0 dai          10.56   src/audio/dai-legacy.c:640  INFO dai_config_prepare(): new configured dma channel index 0
[     1943217.474867] (        1403.697876) c0 ipc                  src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x60040000
[     1943242.631116] (          25.156248) c0 pipe         10.57 ....../pipeline-stream.c:270  INFO pipe trigger cmd 7
[     1943275.026948] (          32.395832) c0 ll-schedule        ./schedule/ll_schedule.c:513  INFO task add 0xbe1e0300 pipe-task <f11818eb-e92e-4082-82a3-dc54c604ebb3>
[     1943294.037364] (          19.010416) c0 ll-schedule        ./schedule/ll_schedule.c:517  INFO task params pri 0 flags 0 start 0 period 1000
[     1943321.849863] (          27.812498) c0 ll-schedule        ./schedule/ll_schedule.c:418  INFO new added task->start 37999679 at 37971729
[     1943339.818612] (          17.968750) c0 ll-schedule        ./schedule/ll_schedule.c:421  INFO num_tasks 3 total_num_tasks 3
[     1944985.026880] (        1645.208252) c0 dmic-dai     2.0   ....../intel/dmic/dmic.c:296  INFO dmic_start(), dmic->fifo_a
[     1945004.870629] (          19.843750) c0 dmic-dai     2.0   ....../intel/dmic/dmic.c:323  INFO dmic_start(), pdm0 mic_a = 1, mic_b = 1
[     1945023.464378] (          18.593750) c0 dmic-dai     2.0   ....../intel/dmic/dmic.c:323  INFO dmic_start(), pdm1 mic_a = 1, mic_b = 1
[     1945044.870628] (          21.406250) c0 dmic-dai     2.0   ....../intel/dmic/dmic.c:387  INFO dmic_start(), dmic_active_fifos_mask = 0x1
Skipped 7272 bytes after the last statement.