*** Booting Zephyr OS build v3.1.0-rc3-18211-g3c3e166d078c ***
[    0.095140] <inf> main: main: SOF on intel_adsp_ace15_mtpm
[    0.095148] <inf> main: main: SOF initialized
[    0.095601] <inf> ipc: ipc_cmd: rx   : 0x43000000|0x20701000
[    0.100400] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x31400008
[    0.106295] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x3060004c
[    1.083716] <inf> ipc: ipc_cmd: rx   : 0x11000005|0x0
[    1.083723] <inf> pipe: pipeline_new: pipeline new pipe_id 0 priority 0
[    1.083998] <inf> ipc: ipc_cmd: rx   : 0x40000004|0x15
[    1.084036] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.084336] <inf> ipc: ipc_cmd: rx   : 0x40000006|0x10
[    1.084918] <inf> ipc: ipc_cmd: rx   : 0x44000006|0x30000018
[    1.085241] <inf> ipc: ipc_cmd: rx   : 0x40000002|0xa
[    1.085585] <inf> ipc: ipc_cmd: rx   : 0x11010006|0x0
[    1.085590] <inf> pipe: pipeline_new: pipeline new pipe_id 1 priority 0
[    1.085908] <inf> ipc: ipc_cmd: rx   : 0x40000003|0x1000a
[    1.086295] <inf> ipc: ipc_cmd: rx   : 0x40010006|0x10010
[    1.086576] <inf> ipc: ipc_cmd: rx   : 0x44010006|0x30000018
[    1.086916] <inf> ipc: ipc_cmd: rx   : 0x40010004|0x10015
[    1.086971] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.086975] <inf> ipc: dai_config: comp:1 0x40001 dai_config() dai type = 3 index = 3 dd 0x40107c80
[    1.087245] <inf> ipc: ipc_cmd: rx   : 0x45000004|0x6
[    1.087258] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087270] <inf> pipe: pipeline_connect: comp:0 0x40000 connect buffer 0 as sink
[    1.087275] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as source
[    1.087623] <inf> ipc: ipc_cmd: rx   : 0x45000006|0x2
[    1.087631] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087645] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as sink
[    1.087648] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as source
[    1.087970] <inf> ipc: ipc_cmd: rx   : 0x45000002|0x3
[    1.087978] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087990] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as sink
[    1.087995] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as source
[    1.088270] <inf> ipc: ipc_cmd: rx   : 0x45000003|0x10006
[    1.088278] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.088290] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as sink
[    1.088295] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as source
[    1.089833] <inf> ipc: ipc_cmd: rx   : 0x45010006|0x10004
[    1.089845] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.089856] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as sink
[    1.089861] <inf> pipe: pipeline_connect: comp:1 0x40001 connect buffer 0 as source
[    1.090913] <inf> ipc: ipc_cmd: rx   : 0x11020004|0x0
[    1.090925] <inf> pipe: pipeline_new: pipeline new pipe_id 2 priority 0
[    1.092000] <inf> ipc: ipc_cmd: rx   : 0x40020004|0x20015
[    1.092056] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.092060] <inf> ipc: dai_config: comp:2 0x40002 dai_config() dai type = 3 index = 0 dd 0x40109c40
[    1.092335] <inf> ipc: ipc_cmd: rx   : 0x40000010|0x2000a
[    1.092366] <inf> eq_iir: eq_iir_init: comp:2 0x100000 eq_iir_init()
[    1.093166] <inf> ipc: ipc_cmd: rx   : 0x44000010|0x30000058
[    1.093181] <inf> eq_iir: eq_iir_set_config: comp:2 0x100000 eq_iir_set_config()
[    1.093495] <inf> ipc: ipc_cmd: rx   : 0x11030002|0x0
[    1.093501] <inf> pipe: pipeline_new: pipeline new pipe_id 3 priority 0
[    1.093833] <inf> ipc: ipc_cmd: rx   : 0x40030004|0x30015
[    1.093880] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.094920] <inf> ipc: ipc_cmd: rx   : 0xd450[   54.147421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4266, overruns able-branch-917-g635bec832707 zephyr:v3.1.0-rc3-18211-g3c3e166d078c src hash 0xaf781b2e (ref hash 0xaf781b2e)
*** Booting Zephyr OS build v3.1.0-rc3-18211-g3c3e166d078c ***
[    0.095140] <inf> main: main: SOF on intel_adsp_ace15_mtpm
[    0.095148] <inf> main: main: SOF initialized
[    0.095601] <inf> ipc: ipc_cmd: rx   : 0x43000000|0x20701000
[    0.100400] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x31400008
[    0.106295] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x3060004c
[    1.083716] <inf> ipc: ipc_cmd: rx   : 0x11000005|0x0
[    1.083723] <inf> pipe: pipeline_new: pipeline new pipe_id 0 priority 0
[    1.083998] <inf> ipc: ipc_cmd: rx   : 0x40000004|0x15
[    1.084036] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.084336] <inf> ipc: ipc_cmd: rx   : 0x40000006|0x10
[    1.084918] <inf> ipc: ipc_cmd: rx   : 0x44000006|0x30000018
[    1.085241] <inf> ipc: ipc_cmd: rx   : 0x40000002|0xa
[    1.085585] <inf> ipc: ipc_cmd: rx   : 0x11010006|0x0
[    1.085590] <inf> pipe: pipeline_new: pipeline new pipe_id 1 priority 0
[    1.085908] <inf> ipc: ipc_cmd: rx   : 0x40000003|0x1000a
[    1.086295] <inf> ipc: ipc_cmd: rx   : 0x40010006|0x10010
[    1.086576] <inf> ipc: ipc_cmd: rx   : 0x44010006|0x30000018
[    1.086916] <inf> ipc: ipc_cmd: rx   : 0x40010004|0x10015
[    1.086971] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.086975] <inf> ipc: dai_config: comp:1 0x40001 dai_config() dai type = 3 index = 3 dd 0x40107c80
[    1.087245] <inf> ipc: ipc_cmd: rx   : 0x45000004|0x6
[    1.087258] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087270] <inf> pipe: pipeline_connect: comp:0 0x40000 connect buffer 0 as sink
[    1.087275] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as source
[    1.087623] <inf> ipc: ipc_cmd: rx   : 0x45000006|0x2
[    1.087631] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087645] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as sink
[    1.087648] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as source
[    1.087970] <inf> ipc: ipc_cmd: rx   : 0x45000002|0x3
[    1.087978] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087990] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as sink
[    1.087995] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as source
[    1.088270] <inf> ipc: ipc_cmd: rx   : 0x45000003|0x10006
[    1.088278] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.088290] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as sink
[    1.088295] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as source
[    1.089833] <inf> ipc: ipc_cmd: rx   : 0x45010006|0x10004
[    1.089845] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.089856] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as sink
[    1.089861] <inf> pipe: pipeline_connect: comp:1 0x40001 connect buffer 0 as source
[    1.090913] <inf> ipc: ipc_cmd: rx   : 0x11020004|0x0
[    1.090925] <inf> pipe: pipeline_new: pipeline new pipe_id 2 priority 0
[    1.092000] <inf> ipc: ipc_cmd: rx   : 0x40020004|0x20015
[    1.092056] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.092060] <inf> ipc: dai_config: comp:2 0x40002 dai_config() dai type = 3 index = 0 dd 0x40109c40
[    1.092335] <inf> ipc: ipc_cmd: rx   : 0x40000010|0x2000a
[    1.092366] <inf> eq_iir: eq_iir_init: comp:2 0x100000 eq_iir_init()
[    1.093166] <inf> ipc: ipc_cmd: rx   : 0x44000010|0x30000058
[    1.093181] <inf> eq_iir: eq_iir_set_config: comp:2 0x100000 eq_iir_set_config()
[    1.093495] <inf> ipc: ipc_cmd: rx   : 0x11030002|0x0
[    1.093501] <inf> pipe: pipeline_new: pipeline new pipe_id 3 priority 0
[    1.093833] <inf> ipc: ipc_cmd: rx   : 0x40030004|0x30015
[    1.093880] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.094920] <inf> ipc: ipc_cmd: rx   : 0xd0
[   55.171421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4231, overruns able-branch-917-g635bec832707 zephyr:v3.1.0-rc3-18211-g3c3e166d078c src hash 0xaf781b2e (ref hash 0xaf781b2e)
*** Booting Zephyr OS build v3.1.0-rc3-18211-g3c3e166d078c ***
[    0.095140] <inf> main: main: SOF on intel_adsp_ace15_mtpm
[    0.095148] <inf> main: main: SOF initialized
[    0.095601] <inf> ipc: ipc_cmd: rx   : 0x43000000|0x20701000
[    0.100400] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x31400008
[    0.106295] <inf> ipc: ipc_cmd: rx   : 0x44000000|0x3060004c
[    1.083716] <inf> ipc: ipc_cmd: rx   : 0x11000005|0x0
[    1.083723] <inf> pipe: pipeline_new: pipeline new pipe_id 0 priority 0
[    1.083998] <inf> ipc: ipc_cmd: rx   : 0x40000004|0x15
[    1.084036] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.084336] <inf> ipc: ipc_cmd: rx   : 0x40000006|0x10
[    1.084918] <inf> ipc: ipc_cmd: rx   : 0x44000006|0x30000018
[    1.085241] <inf> ipc: ipc_cmd: rx   : 0x40000002|0xa
[    1.085585] <inf> ipc: ipc_cmd: rx   : 0x11010006|0x0
[    1.085590] <inf> pipe: pipeline_new: pipeline new pipe_id 1 priority 0
[    1.085908] <inf> ipc: ipc_cmd: rx   : 0x40000003|0x1000a
[    1.086295] <inf> ipc: ipc_cmd: rx   : 0x40010006|0x10010
[    1.086576] <inf> ipc: ipc_cmd: rx   : 0x44010006|0x30000018
[    1.086916] <inf> ipc: ipc_cmd: rx   : 0x40010004|0x10015
[    1.086971] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.086975] <inf> ipc: dai_config: comp:1 0x40001 dai_config() dai type = 3 index = 3 dd 0x40107c80
[    1.087245] <inf> ipc: ipc_cmd: rx   : 0x45000004|0x6
[    1.087258] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087270] <inf> pipe: pipeline_connect: comp:0 0x40000 connect buffer 0 as sink
[    1.087275] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as source
[    1.087623] <inf> ipc: ipc_cmd: rx   : 0x45000006|0x2
[    1.087631] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087645] <inf> pipe: pipeline_connect: comp:0 0x60000 connect buffer 0 as sink
[    1.087648] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as source
[    1.087970] <inf> ipc: ipc_cmd: rx   : 0x45000002|0x3
[    1.087978] <inf> ipc: buffer_new: buffer new size 0x300 id 0.0 flags 0x0
[    1.087990] <inf> pipe: pipeline_connect: comp:0 0x20000 connect buffer 0 as sink
[    1.087995] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as source
[    1.088270] <inf> ipc: ipc_cmd: rx   : 0x45000003|0x10006
[    1.088278] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.088290] <inf> pipe: pipeline_connect: comp:1 0x30000 connect buffer 0 as sink
[    1.088295] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as source
[    1.089833] <inf> ipc: ipc_cmd: rx   : 0x45010006|0x10004
[    1.089845] <inf> ipc: buffer_new: buffer new size 0x300 id 1.0 flags 0x0
[    1.089856] <inf> pipe: pipeline_connect: comp:1 0x60001 connect buffer 0 as sink
[    1.089861] <inf> pipe: pipeline_connect: comp:1 0x40001 connect buffer 0 as source
[    1.090913] <inf> ipc: ipc_cmd: rx   : 0x11020004|0x0
[    1.090925] <inf> pipe: pipeline_new: pipeline new pipe_id 2 priority 0
[    1.092000] <inf> ipc: ipc_cmd: rx   : 0x40020004|0x20015
[    1.092056] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[    1.092060] <inf> ipc: dai_config: comp:2 0x40002 dai_config() dai type = 3 index = 0 dd 0x40109c40
[    1.092335] <inf> ipc: ipc_cmd: rx   : 0x40000010|0x2000a
[    1.092366] <inf> eq_iir: eq_iir_init: comp:2 0x100000 eq_iir_init()
[    1.093166] <inf> ipc: ipc_cmd: rx   : 0x44000010|0x30000058
[    1.093181] <inf> eq_iir: eq_iir_set_config: comp:2 0x100000 eq_iir_set_config()
[    1.093495] <inf> ipc: ipc_cmd: rx   : 0x11030002|0x0
[    1.093501] <inf> pipe: pipeline_new: pipeline new pipe_id 3 priority 0
[    1.093833] <inf> ipc: ipc_cmd: rx   : 0x40030004|0x30015
[    1.093880] <inf> dma: dma_get: dma_get() ID 0 sref = 1 busy channels 0
[   89.987421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4260, overruns 0
[   91.011421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4236, overruns 0
[   92.035421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4240, overruns 0
[   93.059421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4271, overruns 0
[   94.083421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4237, overruns 0
[   95.107421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[   96.131421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4231, overruns 0
[   97.155421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4234, overruns 0
[   98.179421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4267, overruns 0
[   99.203421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4237, overruns 0
[  100.227421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4261, overruns 0
[  101.251421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4234, overruns 0
[  102.275421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4235, overruns 0
[  103.299421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[  104.323421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4238, overruns 0
[  105.347421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[  106.371423] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4233, overruns 0
[  107.395423] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4234, overruns 0
[  108.419421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4270, overruns 0
[  109.443421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4239, overruns 0
[  110.467421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4267, overruns 0
[  111.491421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4234, overruns 0
[    0.667316] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4235, overruns 0
[    1.691315] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4270, overruns d0
[    2.715315] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4237, overruns 0
[   91.011421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4236, overruns 0
[   92.035421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4240, overruns 0
[   93.059421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4271, overruns 0
[   94.083421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4237, overruns 0
[   95.107421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[   96.131421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4231, overruns 0
[   97.155421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4234, overruns 0
[   98.179421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4267, overruns 0
[   99.203421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4237, overruns 0
[  100.227421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4261, overruns 0
[  101.251421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4234, overruns 0
[  102.275421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4235, overruns 0
[  103.299421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[  104.323421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4238, overruns 0
[  105.347421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4268, overruns 0
[  106.371423] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4233, overruns 0
[  107.395423] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3791, max 4234, overruns 0
[  108.419421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4270, overruns 0
[  109.443421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4239, overruns 0
[  110.467421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4267, overruns 0
[  111.491421] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4234, overruns 0
[    0.667316] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4235, overruns 0
[    1.691315] <inf> ll_schedule: zephyr_domain_thread_fn: ll timer avg 3790, max 4270, overruns 0