[ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033050] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033420] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033430] main: sof_app_main: SOF initialized [ 0.033816] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034313] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.035743] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.035755] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.036290] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.036371] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.036801] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.037390] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.037891] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.038361] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.038375] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.038795] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.039385] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.039778] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.039791] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.040270] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.040650] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.041248] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.041673] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.042033] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.042395] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.042483] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.042516] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.042545] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.042560] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.042585] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.042601] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.042613] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.042625] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.042638] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.043225] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.043243] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.043271] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.043283] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.045890] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.045923] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.045953] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.045965] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.046440] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.046480] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.046510] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.046521] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.046988] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.047013] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.047043] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.047053] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.047446] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.047466] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.047495] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.047506] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.047901] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.047921] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.047950] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.047961] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.048368] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.048390] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.048418] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.048430] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.048848] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.048868] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.048898] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.048910] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.049536] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.049598] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.049625] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.050150] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.050413] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.050421] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.050430] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.050440] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.050451] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.050461] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.050470] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.050478] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.050518] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.050620] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.050738] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.050788] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.050826] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.050845] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.050891] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.051015] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.051025] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.051033] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.051043] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.051055] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.051078] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.051091] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.051103] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.061088] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.061115] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.071186] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.071203] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.072128] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.073055] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.074053] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.075055] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.076053] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.077053] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.078055] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.079053] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.080055] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.081050] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.074068] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2485, max 7905, overruns 0 [ 2.098068] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2465, max 3921, overruns [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033176] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033548] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033558] main: sof_app_main: SOF initialized [ 0.033958] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034385] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.690998] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.691026] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.693240] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.693323] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.693743] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.694896] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.695360] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.695821] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.695835] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.696756] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.697195] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.697810] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.697840] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.698543] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.699466] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.699866] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.700353] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.701198] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.701558] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.701646] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.701656] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.701685] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.701715] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.701741] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.701756] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.701768] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.701781] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.701793] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.702218] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.702236] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.702265] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.702276] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.702726] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.702743] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.702773] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.702785] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.703333] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.703351] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.703381] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.703393] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.706023] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.706051] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.706081] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.706093] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.706395] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.706435] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.706465] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.706476] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.708011] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.708043] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.708071] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.708083] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.708421] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.708463] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.708493] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.708505] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.708900] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.708920] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.708950] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.708961] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.709453] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.709515] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.709541] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.709946] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.710116] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.710125] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.710135] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.710143] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.710155] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.710165] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.710173] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.710183] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.710221] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.710321] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.710441] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.710491] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.710530] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.710548] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.710595] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.710671] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.710680] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.710688] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.710698] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.710711] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.710735] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.710746] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.710758] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.710885] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.710901] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.720975] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.721001] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.721796] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.722721] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.723720] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.724721] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.725720] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.726721] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.727721] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.728720] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.729723] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.730706] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.733721] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2493, max 7896, overruns 0 [ 2.757721] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2460, max 2532, overruns 0 [ 3.781720] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2459, max 2510, overruns 0 [ 4.805721] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2460, max 3052, overruns 0 [ 5.829721] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2460, max 2504, overruns 0 [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033065] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033435] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033445] main: sof_app_main: SOF initialized [ 0.033843] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034313] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.742576] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.742598] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.743105] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.743188] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.743800] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.744505] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.745293] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.745691] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.745705] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.746020] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.746433] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.746856] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.746870] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.747558] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.747983] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.748580] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.749013] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.749370] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.750611] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.750710] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.750720] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.750750] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.750763] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.750811] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.750826] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.750838] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.750851] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.750863] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.752328] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.752355] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.752385] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.752396] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.752781] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.752821] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.752850] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.752861] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.754575] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.754603] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.754631] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.754643] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.755013] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.755053] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.755081] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.755093] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.755491] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.755511] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.755540] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.755551] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.755956] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.755976] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.756005] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.756016] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.756425] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.756446] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.756475] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.756486] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.756915] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.756936] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.756966] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.756976] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.757473] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.757535] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.757561] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.757971] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.758140] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.758150] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.758158] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.758166] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.758180] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.758188] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.758196] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.758206] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.758245] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.758346] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.758465] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.758515] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.758553] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.758571] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.758618] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.758823] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.758831] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.758840] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.758850] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.758863] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.758886] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.758898] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.758910] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.768776] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.768803] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.778928] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.778945] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.779803] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.780730] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.781728] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.782728] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.783728] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.784728] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.785730] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.786726] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.787730] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.788725] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.781741] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2484, max 7915, overruns 0 [ 2.805743] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2465, max 2524, overruns 0 [ 3.829741] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2462, max 2521, overruns 0 [ 4.853741] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2464, max 3138, overruns 0 [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033040] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033411] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033421] main: sof_app_main: SOF initialized [ 0.033683] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034075] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.754285] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.754308] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.755648] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.755731] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.756140] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.757868] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.758761] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.759265] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.759278] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.759666] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.760113] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.760631] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.760655] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.761066] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.761586] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.762318] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.762900] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.763355] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.764271] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.764360] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.764368] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.764420] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.764435] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.764460] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.764475] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.764488] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.764500] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.764513] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.765668] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.765685] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.765715] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.765731] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.767535] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.767563] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.767593] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.767605] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.768706] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.768746] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.768776] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.768788] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.770448] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.770478] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.770506] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.770518] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.770941] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.770983] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.771011] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.771023] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.771978] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.772000] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.772028] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.772040] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.772551] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.772573] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.772601] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.772613] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.773286] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.773318] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.773346] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.773358] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.775213] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.775283] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.775311] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.775983] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.776151] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.776176] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.776186] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.776195] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.776208] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.776216] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.776225] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.776235] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.776273] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.776375] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.776493] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.776545] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.776583] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.776601] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.776646] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.776730] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.776740] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.776748] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.776756] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.776770] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.776793] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.776806] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.776818] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.787041] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.787068] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.797173] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.797190] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.797848] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.798775] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.799773] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.800775] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.801770] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.802773] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.803775] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.804773] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.805773] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.806770] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.799788] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2481, max 7921, overruns 0 [ 2.823786] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2459, max 2525, overruns 0 [ 3.847786] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2459, max 2527, overruns 0 [ 4.871786] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2520, overruns 0 [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033206] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033576] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033586] main: sof_app_main: SOF initialized [ 0.033848] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034290] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.738390] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.738411] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.740345] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.740433] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.740841] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.741591] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.742308] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.742716] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.742730] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.743110] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.743626] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.744060] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.744085] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.744566] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.745046] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.745510] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.746006] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.749218] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.749651] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.749740] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.749748] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.749778] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.749808] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.749833] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.749848] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.749861] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.749873] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.749886] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.750311] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.750328] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.750358] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.750368] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.750818] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.750835] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.750865] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.750876] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.751425] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.751443] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.751471] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.751483] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.754021] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.754050] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.754080] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.754091] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.756076] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.756118] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.756146] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.756158] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.756551] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.756571] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.756601] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.756613] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.757008] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.757030] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.757058] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.757070] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.757416] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.757436] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.757466] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.757478] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.757978] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.758040] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.758068] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.758551] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.758720] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.758728] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.758738] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.758746] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.758760] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.758768] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.758776] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.758786] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.758825] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.758925] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.759045] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.759095] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.759133] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.759151] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.759196] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.759290] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.759300] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.759308] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.759316] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.759330] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.759353] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.759365] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.759378] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.769371] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.769398] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.779470] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.779486] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.780411] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.781336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.782335] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.783336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.784335] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.785336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.786336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.787336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.788336] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.789333] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.782350] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2477, max 7912, overruns 0 [ 2.806348] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2530, overruns 0 [ 3.830348] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2457, max 2525, overruns 0 [ 4.854350] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2457, max 3130, overruns 0 [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7d000 initialized [ 0.000000] dma_intel_adsp_gpdma: intel_adsp_gpdma_power_on: intel_adsp_gpdma_power_on: dma dma@7c000 initialized [ 0.033130] init: print_version_banner: FW ABI 0x301d000 DBG ABI 0x5003000 tags SOF:v2.5-stable-branch-1860-gddf70fa033a8 zephyr:zephyr-v3.5.0-2983-g0a7251e365af src hash 0x3020526c (ref hash 0x3020526c) *** Booting Zephyr OS build zephyr-v3.5.0-2983-g0a7251e365af *** [ 0.033500] main: sof_app_main: SOF on intel_adsp_cavs25 [ 0.033510] main: sof_app_main: SOF initialized [ 0.033910] ipc: ipc_cmd: rx : 0x44000000|0x31400008 [ 0.034416] ipc: ipc_cmd: rx : 0x44000000|0x3060004c [ 0.738995] ipc: ipc_cmd: rx : 0x11000005|0x0 [ 0.739018] pipe: pipeline_new: pipeline new pipe_id 0 priority 0 [ 0.739430] ipc: ipc_cmd: rx : 0x40000004|0x15 [ 0.739526] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.740406] ipc: ipc_cmd: rx : 0x40000006|0x10 [ 0.741201] ipc: ipc_cmd: rx : 0x44000006|0x30000018 [ 0.741758] ipc: ipc_cmd: rx : 0x40000002|0xa [ 0.742310] ipc: ipc_cmd: rx : 0x11010004|0x0 [ 0.742323] pipe: pipeline_new: pipeline new pipe_id 1 priority 0 [ 0.743498] ipc: ipc_cmd: rx : 0x40000003|0x1000a [ 0.744023] ipc: ipc_cmd: rx : 0x40010002|0x1000a [ 0.744458] ipc: ipc_cmd: rx : 0x11020008|0x0 [ 0.744481] pipe: pipeline_new: pipeline new pipe_id 2 priority 0 [ 0.744905] ipc: ipc_cmd: rx : 0x40010003|0x2000a [ 0.745791] ipc: ipc_cmd: rx : 0x40010006|0x20010 [ 0.746300] ipc: ipc_cmd: rx : 0x44010006|0x30000018 [ 0.747946] ipc: ipc_cmd: rx : 0x40000009|0x20026 [ 0.748415] ipc: ipc_cmd: rx : 0x44000009|0x30200018 [ 0.750866] ipc: ipc_cmd: rx : 0x40010004|0x2002c [ 0.750955] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power en_ssp_power index 0 [ 0.750963] dai_intel_ssp: dai_ssp_pm_runtime_en_ssp_power: dai_ssp_pm_runtime_en_ssp_power I2SLCTL [ 0.751015] dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0 [ 0.751030] ipc: dai_config: comp:2 0x10004 dai_config() dai type = 1 index = 0 dd 0x9e0c0040 [ 0.751055] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config: Ignoring SSCR1:TSRE SSCR1:RSRE from blob [ 0.751070] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr0 = 0xc1d0077f, sscr1 = 0xd0400004, ssto = 0x00000000, sspsp = 0x2200000 [ 0.751083] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config sscr2 = 0x00004002, sspsp2 = 0x00000000, sscr3 = 0x07070000 [ 0.751095] dai_intel_ssp: dai_ssp_set_reg_config: dai_ssp_set_reg_config ssioc = 0x00000020, ssrsa = 0x00000003, sstsa = 0x00000003 [ 0.751108] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 0, mask 80, value 80 [ 0.751613] ipc: ipc_cmd: rx : 0x45000004|0x6 [ 0.751630] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.751660] pipe: pipeline_connect: comp:0 0x4 connect buffer 0 as sink [ 0.751671] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as source [ 0.752141] ipc: ipc_cmd: rx : 0x45000006|0x2 [ 0.752158] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.752188] pipe: pipeline_connect: comp:0 0x6 connect buffer 0 as sink [ 0.752200] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as source [ 0.752891] ipc: ipc_cmd: rx : 0x45000002|0x3 [ 0.752910] ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0 [ 0.752938] pipe: pipeline_connect: comp:0 0x2 connect buffer 0 as sink [ 0.752950] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as source [ 0.753325] ipc: ipc_cmd: rx : 0x45000003|0x10002 [ 0.753418] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.753446] pipe: pipeline_connect: comp:1 0x3 connect buffer 0 as sink [ 0.753458] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as source [ 0.756755] ipc: ipc_cmd: rx : 0x45010002|0x10003 [ 0.756785] ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0 [ 0.756815] pipe: pipeline_connect: comp:1 0x10002 connect buffer 0 as sink [ 0.756825] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as source [ 0.757371] ipc: ipc_cmd: rx : 0x45010003|0x10006 [ 0.757413] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.757443] pipe: pipeline_connect: comp:2 0x10003 connect buffer 0 as sink [ 0.757453] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as source [ 0.758506] ipc: ipc_cmd: rx : 0x45010006|0x9 [ 0.758536] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.758566] pipe: pipeline_connect: comp:2 0x10006 connect buffer 0 as sink [ 0.758578] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as source [ 0.758975] ipc: ipc_cmd: rx : 0x45000009|0x10004 [ 0.758996] ipc: buffer_new: buffer new size 0x300 id 2.0 flags 0x0 [ 0.759025] pipe: pipeline_connect: comp:2 0x9 connect buffer 0 as sink [ 0.759036] pipe: pipeline_connect: comp:2 0x10004 connect buffer 0 as source [ 0.760678] ipc: ipc_cmd: rx : 0x13000003|0x1 [ 0.760748] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 65538 [ 0.760776] ipc: ipc_pipeline_complete: ipc_pipeline_complete(): no scheduling component specified, use comp 2 [ 0.761473] ipc: ipc_cmd: rx : 0x13000004|0x1 [ 0.761643] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.761666] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.761676] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.761685] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.761698] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.761706] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.761715] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.761725] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.761763] copier: copier_prepare: comp:2 0x10004 copier_prepare() [ 0.761865] mixer: mixin_prepare: comp:1 0x10002 mixin_prepare() [ 0.761983] copier: copier_prepare: comp:0 0x4 copier_prepare() [ 0.762035] mixer: mixin_prepare: comp:0 0x2 mixin_prepare() [ 0.762073] pipe: pipeline_trigger: pipe:2 0x0 pipe trigger cmd 7 [ 0.762090] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c2900 0x201b0U priority 0 flags 0x0 [ 0.762136] ll_schedule: zephyr_domain_register: zephyr_domain_register domain->type 1 domain->clk 4 domain->ticks_per_ms 38400 period 1000 [ 0.762215] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties dai_index 0 [ 0.762223] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties fifo 487440 [ 0.762231] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties handshake 2 [ 0.762241] dai_intel_ssp: dai_ssp_get_properties: dai_ssp_get_properties init delay 0 [ 0.762255] dai_intel_ssp: dai_ssp_pre_start: dai_ssp_pre_start [ 0.762278] dai_intel_ssp: dai_ssp_start: dai_ssp_start [ 0.762290] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 4, mask 200000, value 200000 [ 0.762301] dai_intel_ssp: dai_ssp_update_bits: dai_ssp_update_bits base 77000, reg 30, mask 100, value 100 [ 0.762428] pipe: pipeline_trigger: pipe:1 0x0 pipe trigger cmd 7 [ 0.762445] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3600 0x201b0U priority 0 flags 0x0 [ 0.772526] pipe: pipeline_trigger: pipe:0 0x0 pipe trigger cmd 7 [ 0.772553] ll_schedule: zephyr_ll_task_schedule_common: task add 0xbe0c3b80 0x201b0U priority 0 flags 0x0 [ 0.773350] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.774275] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.775273] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.776275] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.777273] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.778273] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.779273] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.780273] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.781275] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 0.782258] host_comp: host_get_copy_bytes_normal: comp:0 0x4 no bytes to copy, available samples: 0, free_samples: 192 [ 1.785273] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2489, max 7902, overruns 0 [ 2.809273] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2515, overruns 0 [ 3.833273] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2518, overruns 0 [ 4.857273] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2516, overruns 0 [ 5.881273] ll_schedule: zephyr_domain_thread_fn: ll core 0 timer avg 2458, max 2517, overruns 0 Terminated