TIMESTAMP (us) DELTA C# COMPONENT LOCATION CONTENT ktime=37.682s @ 2024-07-15 10:45:10 +0800 +08 [ 14163444.072612] ( 0.000000) c0 dma-trace src/trace/dma-trace.c:352 INFO DMA: FW ABI 0x3017000 DBG ABI 0x5003000 tags SOF:v0.0-0-g0000 src hash 0xb2852fb2 (ldc hash 0xb2852fb2) [ 131.145828] ( 131.145828) c0 ll-schedule ./schedule/ll_schedule.c:513 INFO task add 0x9e1be370 dma-trace-task <2b972272-c5b1-4b7e-926f-0fc5cb4c4690> [ 149.791661] ( 18.645832) c0 ll-schedule ./schedule/ll_schedule.c:517 INFO task params pri 4 flags 0 start 500000 period 500000 [ 177.552076] ( 27.760416) c0 ll-schedule ./schedule/ll_schedule.c:418 INFO new added task->start 3956826 at 3937529 [ 195.364576] ( 17.812500) c0 ll-schedule ./schedule/ll_schedule.c:421 INFO num_tasks 2 total_num_tasks 2 [ 463286.908674] ( 463091.531250) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x40070000 [ 463308.054506] ( 21.145832) c0 ipc src/ipc/ipc3/handler.c:716 INFO ipc: pm core mask 0x3 -> enable [ 463498.575332] ( 190.520828) c1 edf-schedule /schedule/edf_schedule.c:259 INFO edf_scheduler_init() [ 463604.200328] ( 105.624992) c1 idc src/idc/idc.c:351 INFO idc_init() [ 463924.669065] ( 320.468750) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x30100000 [ 463957.637814] ( 32.968750) c1 idc ......./intel/cavs/idc.c:58 INFO idc_irq_handler(), IPC_IDCTFC_BUSY [ 463981.544063] ( 23.906250) c1 idc ......./intel/cavs/idc.c:186 INFO idc_do_cmd() [ 464006.231562] ( 24.687498) c1 pipe ......./pipeline-graph.c:116 INFO pipeline new pipe_id 29 priority 0 [ 464024.356561] ( 18.125000) c1 memory src/lib/alloc.c:595 INFO heap: system status [ 464043.106561] ( 18.750000) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe0d0000 size 32768 blocks 0 caps 0x45 [ 464061.648227] ( 18.541666) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 6912 free 25856 [ 464077.377393] ( 15.729166) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1c0000 size 24576 blocks 0 caps 0x45 [ 464094.200309] ( 16.822916) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 9504 free 15072 [ 464110.398225] ( 16.197916) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1d0000 size 24576 blocks 0 caps 0x45 [ 464126.439891] ( 16.041666) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 24576 [ 464141.960723] ( 15.520833) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1e0000 size 24576 blocks 0 caps 0x45 [ 464157.846139] ( 15.885416) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 24576 [ 464175.241972] ( 17.395832) c1 memory src/lib/alloc.c:597 INFO heap: system runtime status [ 464207.221137] ( 31.979166) c1 memory src/lib/alloc.c:578 INFO 64 Bytes blocks ID:0 base 0xbe0d8000 [ 464225.033637] ( 17.812500) c1 memory src/lib/alloc.c:582 INFO Number of Blocks: total 128sed 10 free 118 [ 464242.846136] ( 17.812500) c1 memory src/lib/alloc.c:578 INFO 512 Bytes blocks ID:1 base 0xbe0da000 [ 464261.856552] ( 19.010416) c1 memory src/lib/alloc.c:582 INFO Number of Blocks: total 16sed 0 free 16 [ 464275.137801] ( 13.281249) c1 dma-trace src/trace/trace.c:141 INFO Suppressed 1 similar messages: heap: 0x%x size %d blocks %d caps 0x%x [ 464285.866968] ( 10.729166) c1 dma-trace src/trace/trace.c:141 INFO Suppressed 1 similar messages: (In Bytes) used %d free %d [ 464300.137800] ( 14.270833) c1 memory src/lib/alloc.c:578 INFO 1024 Bytes blocks ID:2 base 0xbe0dc000 [ 464317.898216] ( 17.760416) c1 memory src/lib/alloc.c:582 INFO Number of Blocks: total 4sed 0 free 4 [ 464335.710716] ( 17.812500) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1c6000 size 12288 blocks 3 caps 0x65 [ 464353.471132] ( 17.760416) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 384 free 11904 [ 464371.960714] ( 18.489582) c1 memory src/lib/alloc.c:578 INFO 64 Bytes blocks ID:0 base 0xbe1c6000 [ 464390.241963] ( 18.281250) c1 memory src/lib/alloc.c:582 INFO Number of Blocks: total 64sed 6 free 58 [ 464407.169046] ( 16.927082) c1 memory src/lib/alloc.c:578 INFO 512 Bytes blocks ID:1 base 0xbe1c7000 [ 464435.189878] ( 28.020832) c1 memory src/lib/alloc.c:578 INFO 1024 Bytes blocks ID:2 base 0xbe1c8000 [ 464462.481544] ( 27.291666) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1d6000 size 12288 blocks 3 caps 0x65 [ 464480.241960] ( 17.760416) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 12288 [ 464497.169043] ( 16.927082) c1 memory src/lib/alloc.c:578 INFO 64 Bytes blocks ID:0 base 0xbe1d6000 [ 464562.325290] ( 65.156250) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1e6000 size 12288 blocks 3 caps 0x65 [ 464579.877373] ( 17.552082) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 12288 [ 464652.429453] ( 72.552078) c1 memory src/lib/alloc.c:599 INFO heap: buffer status [ 464670.658619] ( 18.229166) c1 memory src/lib/alloc.c:569 INFO heap: 0x9e270000 size 458752 blocks 1 caps 0x71 [ 464688.523202] ( 17.864582) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 30208 free 428544 [ 464723.210700] ( 34.687500) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe801800 size 59392 blocks 1 caps 0x69 [ 464741.544033] ( 18.333332) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 59392 [ 464777.273198] ( 35.729164) c1 memory src/lib/alloc.c:601 INFO heap: runtime status [ 464793.314864] ( 16.041666) c1 memory src/lib/alloc.c:569 INFO heap: 0xbe1f0000 size 524288 blocks 7 caps 0x45 [ 464811.023197] ( 17.708332) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 524288 [ 464956.596108] ( 145.572906) c1 memory src/lib/alloc.c:604 INFO heap: runtime shared status [ 464974.356524] ( 17.760416) c1 memory src/lib/alloc.c:569 INFO heap: 0x9e0de000 size 917504 blocks 5 caps 0x45 [ 464992.116940] ( 17.760416) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 2368 free 915136 [ 465102.221102] ( 110.104164) c1 memory src/lib/alloc.c:606 INFO heap: system shared status [ 465119.877351] ( 17.656250) c1 memory src/lib/alloc.c:569 INFO heap: 0x9e1be000 size 5376 blocks 0 caps 0x45 [ 465137.637767] ( 17.760416) c1 memory src/lib/alloc.c:571 INFO (In Bytes) used 3904 free 1472 [ 465483.991920] ( 346.354156) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x30010000 [ 465510.085669] ( 26.093748) c1 dma-trace src/trace/trace.c:141 INFO Suppressed 19 similar messages: %d Bytes blocks ID:%d base 0x%x [ 465522.950252] ( 12.864583) c1 dma-trace src/trace/trace.c:141 INFO Suppressed 22 similar messages: Number of Blocks: total % used %d free %d [ 465536.075251] ( 13.124999) c1 idc ......./intel/cavs/idc.c:58 INFO idc_irq_handler(), IPC_IDCTFC_BUSY [ 465558.731500] ( 22.656250) c1 idc ......./intel/cavs/idc.c:186 INFO idc_do_cmd() [ 465588.210666] ( 29.479166) c1 component src/ipc/ipc3/helper.c:315 INFO comp new dai type 2 id 29.64 [ 465615.033581] ( 26.822916) c1 dai src/audio/dai.c:162 ERROR dai_new() [ 465631.335664] ( 16.302082) c1 dai src/audio/dai.c:165 INFO config: core 1, id 0x40, pid 0x1d, type 2 [ 465658.002330] ( 26.666666) c1 dai src/audio/dai.c:172 INFO comp_dev(0x9e0fe080) [ 465676.596079] ( 18.593750) c1 dai src/audio/dai.c:175 INFO comp_ipc_config: core 1, id 0x0, pid 0x0, type 2 [ 465694.825245] ( 18.229166) c1 dai src/audio/dai.c:178 INFO origin: core 1, id 0x40, pid 0x1d, type 2 [ 465738.471077] ( 43.645832) c1 power ../cavs/lib/pm_runtime.c:186 INFO en_ssp_power index 1 [ 465757.116909] ( 18.645832) c1 power ../cavs/lib/pm_runtime.c:195 INFO en_ssp_power I2SLCTL 00000202 [ 465775.918992] ( 18.802082) c1 dai src/lib/dai.c:166 INFO dai_get type 1 index 1 new sref 1 [ 465872.481488] ( 96.562492) c1 dma src/lib/dma.c:123 INFO dma_get() ID 0 sref = 1 busy channels 0 [ 465890.346071] ( 17.864582) c1 ipc src/ipc/ipc3/helper.c:329 INFO comp_dev(0x9e0fe080): [ 465907.793986] ( 17.447916) c1 ipc src/ipc/ipc3/helper.c:332 INFO comp_ipc_config: core 1, id 0x0, pid 0x0, type 2 [ 465937.168985] ( 29.374998) c1 ipc src/ipc/ipc3/helper.c:688 ERROR ipc_comp_new(): add ipc_comp_dev(0x9e0de5c0) to comp_list [ 465954.460651] ( 17.291666) c1 ipc src/ipc/ipc3/helper.c:690 INFO comp_dev(0x9e0fe080): [ 465972.793984] ( 18.333332) c1 ipc src/ipc/ipc3/helper.c:693 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 2 [ 466263.002306] ( 290.208313) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x80010000 [ 466289.721055] ( 26.718748) c0 ipc src/ipc/ipc3/handler.c:595 INFO ipc: dai 1.1 -> config [ 466309.981471] ( 20.260416) c0 dai src/lib/dai.c:166 INFO dai_get type 1 index 1 new sref 2 [ 466330.658553] ( 20.677082) c0 ssp-dai 1.1 /drivers/intel/ssp/ssp.c:302 INFO ssp_set_config(), config->format = 0x4001 [ 466357.481469] ( 26.822916) c0 ssp-dai 1.1 /drivers/intel/ssp/ssp.c:729 INFO ssp_set_config(), sscr0 = 0xc1d00037, sscr1 = 0xd0400000, ssto = 0x00000000, sspsp = 0xa200000 [ 466376.491885] ( 19.010416) c0 ssp-dai 1.1 /drivers/intel/ssp/ssp.c:731 INFO ssp_set_config(), sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000, ssioc = 0x00000020 [ 466395.450217] ( 18.958332) c0 ssp-dai 1.1 /drivers/intel/ssp/ssp.c:733 INFO ssp_set_config(), ssrsa = 0x00000003, sstsa = 0x00000003 [ 466417.741883] ( 22.291666) c0 mn ./drivers/intel/ssp/mn.c:259 INFO mclk_rate 24576000, mclk_source_clock 0 [ 466436.439799] ( 18.697916) c0 mn ./drivers/intel/ssp/mn.c:220 INFO mclk_id 0 mdivr_val 1 [ 466456.491881] ( 20.052082) c0 ssp-dai 1.1 /drivers/intel/ssp/ssp.c:747 INFO ssp_set_config(): enable MCLK for SSP1 [ 466476.543964] ( 20.052082) c0 dai src/lib/dai.c:190 INFO dai_put type 1 index 1 new sref 1 [ 466496.543963] ( 20.000000) c0 ipc src/ipc/ipc3/dai.c:186 INFO ipc_comp_dai_config() dai type = 1 index = 1 [ 466515.762712] ( 19.218750) c0 ipc src/ipc/ipc3/dai.c:196 INFO comp_dev(0x9e0fe080): [ 466534.721045] ( 18.958332) c0 ipc src/ipc/ipc3/dai.c:199 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 2 [ 466564.148127] ( 29.427082) c1 idc ......./intel/cavs/idc.c:58 INFO idc_irq_handler(), IPC_IDCTFC_BUSY [ 466588.106459] ( 23.958332) c1 idc ......./intel/cavs/idc.c:186 INFO idc_do_cmd() [ 466615.241875] ( 27.135416) c1 ipc src/ipc/ipc3/handler.c:595 INFO ipc: dai 1.1 -> config [ 466633.679374] ( 18.437500) c1 ipc src/ipc/ipc3/dai.c:186 INFO ipc_comp_dai_config() dai type = 1 index = 1 [ 466652.741874] ( 19.062500) c1 ipc src/ipc/ipc3/dai.c:196 INFO comp_dev(0x9e0fe080): [ 466671.335623] ( 18.593750) c1 ipc src/ipc/ipc3/dai.c:199 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 2 [ 466943.054362] ( 271.718750) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x30100000 [ 466967.221028] ( 24.166666) c0 pipe ......./pipeline-graph.c:116 INFO pipeline new pipe_id 14 priority 0 [ 466985.189777] ( 17.968750) c0 memory src/lib/alloc.c:595 INFO heap: system status [ 467003.679360] ( 18.489582) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe0d0000 size 32768 blocks 0 caps 0x45 [ 467022.429359] ( 18.750000) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 6912 free 25856 [ 467040.762691] ( 18.333332) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1c0000 size 24576 blocks 0 caps 0x45 [ 467057.116857] ( 16.354166) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 9504 free 15072 [ 467075.971023] ( 18.854166) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1d0000 size 24576 blocks 0 caps 0x45 [ 467091.387689] ( 15.416666) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 24576 [ 467109.408522] ( 18.020832) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1e0000 size 24576 blocks 0 caps 0x45 [ 467124.929355] ( 15.520833) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 24576 [ 467142.846021] ( 17.916666) c0 memory src/lib/alloc.c:597 INFO heap: system runtime status [ 467225.137684] ( 82.291664) c0 memory src/lib/alloc.c:578 INFO 64 Bytes blocks ID:0 base 0xbe0d8000 [ 467240.918934] ( 15.781249) c0 dma-trace src/trace/trace.c:141 INFO Suppressed 1 similar messages: heap: 0x%x size %d blocks %d caps 0x%x [ 467255.085600] ( 14.166666) c0 memory src/lib/alloc.c:582 INFO Number of Blocks: total 128sed 10 free 118 [ 467268.106432] ( 13.020833) c0 dma-trace src/trace/trace.c:141 INFO Suppressed 1 similar messages: (In Bytes) used %d free %d [ 467284.460598] ( 16.354166) c0 memory src/lib/alloc.c:578 INFO 512 Bytes blocks ID:1 base 0xbe0da000 [ 467300.241848] ( 15.781249) c0 memory src/lib/alloc.c:582 INFO Number of Blocks: total 16sed 0 free 16 [ 467316.075181] ( 15.833333) c0 memory src/lib/alloc.c:578 INFO 1024 Bytes blocks ID:2 base 0xbe0dc000 [ 467332.116847] ( 16.041666) c0 memory src/lib/alloc.c:582 INFO Number of Blocks: total 4sed 0 free 4 [ 467350.502262] ( 18.385416) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1c6000 size 12288 blocks 3 caps 0x65 [ 467368.366845] ( 17.864582) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 384 free 11904 [ 467384.356428] ( 15.989583) c0 memory src/lib/alloc.c:578 INFO 64 Bytes blocks ID:0 base 0xbe1c6000 [ 467400.658510] ( 16.302082) c0 memory src/lib/alloc.c:582 INFO Number of Blocks: total 64sed 6 free 58 [ 467416.700177] ( 16.041666) c0 memory src/lib/alloc.c:578 INFO 512 Bytes blocks ID:1 base 0xbe1c7000 [ 467458.314758] ( 41.614582) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1d6000 size 12288 blocks 3 caps 0x65 [ 467476.387674] ( 18.072916) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 12288 [ 467538.991838] ( 62.604164) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1e6000 size 12288 blocks 3 caps 0x65 [ 467557.793921] ( 18.802082) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 12288 [ 467620.085585] ( 62.291664) c0 memory src/lib/alloc.c:599 INFO heap: buffer status [ 467639.043918] ( 18.958332) c0 memory src/lib/alloc.c:569 INFO heap: 0x9e270000 size 458752 blocks 1 caps 0x71 [ 467657.168917] ( 18.125000) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 30208 free 428544 [ 467690.345999] ( 33.177082) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe801800 size 59392 blocks 1 caps 0x69 [ 467709.616832] ( 19.270832) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 0 free 59392 [ 467742.273080] ( 32.656250) c0 memory src/lib/alloc.c:601 INFO heap: runtime status [ 467760.241830] ( 17.968750) c0 memory src/lib/alloc.c:569 INFO heap: 0xbe1f0000 size 524288 blocks 7 caps 0x45 [ 467779.043912] ( 18.802082) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 128 free 524160 [ 467900.345991] ( 121.302078) c0 memory src/lib/alloc.c:604 INFO heap: runtime shared status [ 467918.210573] ( 17.864582) c0 memory src/lib/alloc.c:569 INFO heap: 0x9e0de000 size 917504 blocks 5 caps 0x45 [ 467936.595989] ( 18.385416) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 4864 free 912640 [ 468029.252236] ( 92.656250) c0 memory src/lib/alloc.c:606 INFO heap: system shared status [ 468047.220985] ( 17.968750) c0 memory src/lib/alloc.c:569 INFO heap: 0x9e1be000 size 5376 blocks 0 caps 0x45 [ 468065.293901] ( 18.072916) c0 memory src/lib/alloc.c:571 INFO (In Bytes) used 3904 free 1472 [ 468436.075136] ( 370.781250) c0 dma-trace src/trace/trace.c:141 INFO Suppressed 21 similar messages: %d Bytes blocks ID:%d base 0x%x [ 468448.262636] ( 12.187499) c0 dma-trace src/trace/trace.c:141 INFO Suppressed 22 similar messages: Number of Blocks: total % used %d free %d [ 468465.085552] ( 16.822916) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x30010000 [ 468494.720967] ( 29.635416) c0 component src/ipc/ipc3/helper.c:315 INFO comp new dai type 2 id 14.62 [ 468521.804299] ( 27.083332) c0 dai src/audio/dai.c:162 ERROR dai_new() [ 468538.158465] ( 16.354166) c0 dai src/audio/dai.c:165 INFO config: core 0, id 0x3e, pid 0xe, type 2 [ 468564.200131] ( 26.041666) c0 dai src/audio/dai.c:172 INFO comp_dev(0x9e0fe180) [ 468586.752213] ( 22.552082) c0 dai src/audio/dai.c:175 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 0 [ 468604.877213] ( 18.125000) c0 dai src/audio/dai.c:178 INFO origin: core 0, id 0x3e, pid 0xe, type 2 [ 468647.533461] ( 42.656250) c0 power ../cavs/lib/pm_runtime.c:186 INFO en_ssp_power index 2 [ 468666.231377] ( 18.697916) c0 power ../cavs/lib/pm_runtime.c:195 INFO en_ssp_power I2SLCTL 00000606 [ 468685.137626] ( 18.906250) c0 dai src/lib/dai.c:166 INFO dai_get type 1 index 2 new sref 1 [ 468781.491789] ( 96.354164) c0 dma src/lib/dma.c:123 INFO dma_get() ID 1 sref = 1 busy channels 0 [ 468799.668872] ( 18.177082) c0 ipc src/ipc/ipc3/helper.c:329 INFO comp_dev(0x9e0fe180): [ 468817.273038] ( 17.604166) c0 ipc src/ipc/ipc3/helper.c:332 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 0 [ 468846.543870] ( 29.270832) c0 ipc src/ipc/ipc3/helper.c:688 ERROR ipc_comp_new(): add ipc_comp_dev(0x9e0de880) to comp_list [ 468863.627202] ( 17.083332) c0 ipc src/ipc/ipc3/helper.c:690 INFO comp_dev(0x9e0fe180): [ 468882.012618] ( 18.385416) c0 ipc src/ipc/ipc3/helper.c:693 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 0 [ 469275.450103] ( 393.437469) c0 ipc src/ipc/ipc3/handler.c:1605 INFO ipc: new cmd 0x80010000 [ 469302.220935] ( 26.770832) c0 ipc src/ipc/ipc3/handler.c:595 INFO ipc: dai 1.2 -> config [ 469322.273017] ( 20.052082) c0 dai src/lib/dai.c:166 INFO dai_get type 1 index 2 new sref 2 [ 469342.637600] ( 20.364582) c0 ssp-dai 1.2 /drivers/intel/ssp/ssp.c:302 INFO ssp_set_config(), config->format = 0x 304 [ 469369.720932] ( 27.083332) c0 ssp-dai 1.2 /drivers/intel/ssp/ssp.c:729 INFO ssp_set_config(), sscr0 = 0xc0c0003f, sscr1 = 0xc3400000, ssto = 0x00000000, sspsp = 0x2010005 [ 469388.418848] ( 18.697916) c0 ssp-dai 1.2 /drivers/intel/ssp/ssp.c:731 INFO ssp_set_config(), sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x01010000, ssioc = 0x00000020 [ 469407.116764] ( 18.697916) c0 ssp-dai 1.2 /drivers/intel/ssp/ssp.c:733 INFO ssp_set_config(), ssrsa = 0x00000001, sstsa = 0x00000001 [ 469427.741763] ( 20.625000) c0 dai src/lib/dai.c:190 INFO dai_put type 1 index 2 new sref 1 [ 469446.335513] ( 18.593750) c0 ipc src/ipc/ipc3/dai.c:186 INFO ipc_comp_dai_config() dai type = 1 index = 2 [ 469465.398012] ( 19.062500) c0 ipc src/ipc/ipc3/dai.c:196 INFO comp_dev(0x9e0fe080): [ 469484.043844] ( 18.645832) c0 ipc src/ipc/ipc3/dai.c:199 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 0 [ 469501.231344] ( 17.187500) c0 ipc src/ipc/ipc3/dai.c:196 INFO comp_dev(0x9e0fe180): [ 469517.950093] ( 16.718750) c0 ipc src/ipc/ipc3/dai.c:199 INFO comp_ipc_config: core 0, id 0x0, pid 0x0, type 0 [ 469547.689675] ( 29.739582) c1 idc ......./intel/cavs/idc.c:58 INFO idc_irq_handler(), IPC_IDCTFC_BUSY [ 469571.283424] ( 23.593750) c1 idc ......./intel/cavs/idc.c:186 INFO idc_do_cmd()