!!################################ !!ALSA Information Script v 0.5.1 !!################################ !!Script ran on: Thu Sep 15 16:41:29 UTC 2022 !!Linux Distribution !!------------------ Debian GNU/Linux bookworm/sid \n \l PRETTY_NAME="Debian GNU/Linux bookworm/sid" NAME="Debian GNU/Linux" ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" !!DMI Information !!--------------- Manufacturer: Google Product Name: Teemo Product Version: 1.0 Firmware Version: MrChromebox-4.13 System SKU: sku1 Board Vendor: Google Board Name: Teemo !!ACPI Device Status Information !!--------------- /sys/bus/acpi/devices/10EC5663:00/status 15 /sys/bus/acpi/devices/ACPI0003:00/status 15 /sys/bus/acpi/devices/ACPI0008:00/status 15 /sys/bus/acpi/devices/BOOT0000:00/status 11 /sys/bus/acpi/devices/GOOG0004:00/status 11 /sys/bus/acpi/devices/GOOG0014:00/status 11 /sys/bus/acpi/devices/INT3400:00/status 15 /sys/bus/acpi/devices/INT3403:00/status 15 /sys/bus/acpi/devices/INT3403:01/status 15 /sys/bus/acpi/devices/INT344B:00/status 15 /sys/bus/acpi/devices/PNP0103:00/status 15 /sys/bus/acpi/devices/PNP0C02:02/status 15 /sys/bus/acpi/devices/PNP0C02:03/status 15 /sys/bus/acpi/devices/PNP0C0A:00/status 15 /sys/bus/acpi/devices/PNP0C0F:00/status 9 /sys/bus/acpi/devices/PNP0C0F:01/status 9 /sys/bus/acpi/devices/PNP0C0F:02/status 9 /sys/bus/acpi/devices/PNP0C0F:03/status 9 /sys/bus/acpi/devices/PNP0C0F:04/status 9 /sys/bus/acpi/devices/PNP0C0F:05/status 9 /sys/bus/acpi/devices/PNP0C0F:06/status 9 /sys/bus/acpi/devices/PNP0C0F:07/status 9 /sys/bus/acpi/devices/PRP0001:00/status 15 /sys/bus/acpi/devices/R8168:00/status 11 /sys/bus/acpi/devices/device:3b/status 15 !!Kernel Information !!------------------ Kernel release: 5.10.0-13-amd64 Operating System: GNU/Linux Architecture: x86_64 Processor: unknown SMP Enabled: Yes !!ALSA Version !!------------ Driver version: k5.10.0-13-amd64 Library version: 1.2.7.2 Utilities version: 1.2.7 !!Loaded ALSA modules !!------------------- snd_soc_kbl_rt5663_max98927 (card 0) !!Sound Servers on this system !!---------------------------- PipeWire: Installed - Yes (/usr/bin/pipewire) Running - Yes Pulseaudio: Installed - Yes (/usr/bin/pulseaudio) Running - No !!Soundcards recognised by ALSA !!----------------------------- 0 [kblrt5663 ]: kblrt5663 - kblrt5663 kblrt5663 !!PCI Soundcards installed in the system !!-------------------------------------- 00:1f.3 Multimedia audio controller [0401]: Intel Corporation Sunrise Point-LP HD Audio [8086:9d71] (rev 21) DeviceName: Multimedia audio controller !!Modprobe options (Sound related) !!-------------------------------- snd_pcsp: index=-2 snd_atiixp_modem: index=-2 snd_intel8x0m: index=-2 snd_via82xx_modem: index=-2 snd_intel_dspcfg: dsp_driver=2 snd_intel_dspcfg: dyndbg==pmf snd_hda_core: dyndbg==pmf snd_hda_codec: dyndbg==pmf snd_soc_core: dyndbg==pmf snd_soc_skl: dyndbg==pmf !!Loaded sound module options !!--------------------------- !!Module: snd_soc_kbl_rt5663_max98927 * : !!Sysfs card info !!--------------- !!Card: /sys/class/sound/card0 Driver: /sys/bus/platform/drivers/kbl_rt5663_m98927 Tree: /sys/class/sound/card0 |-- controlC0 | |-- dev | |-- device -> ../../card0 | |-- power | |-- subsystem -> ../../../../../../class/sound | `-- uevent |-- device -> ../../../kbl_rt5663 |-- id |-- input17 | |-- capabilities | |-- device -> ../../card0 | |-- event8 | |-- id | |-- modalias | |-- name | |-- phys | |-- power | |-- properties | |-- subsystem -> ../../../../../../class/input | |-- uevent | `-- uniq |-- input18 | |-- capabilities | |-- device -> ../../card0 | |-- event9 | |-- id | |-- modalias | |-- name | |-- phys | |-- power | |-- properties | |-- subsystem -> ../../../../../../class/input | |-- uevent | `-- uniq |-- input19 | |-- capabilities | |-- device -> ../../card0 | |-- event10 | |-- id | |-- modalias | |-- name | |-- phys | |-- power | |-- properties | |-- subsystem -> ../../../../../../class/input | |-- uevent | `-- uniq |-- number |-- pcmC0D0p | |-- dev | |-- device -> ../../card0 | |-- pcm_class | |-- power | |-- subsystem -> ../../../../../../class/sound | `-- uevent |-- pcmC0D1c | |-- dev | |-- device -> ../../card0 | |-- pcm_class | |-- power | |-- subsystem -> ../../../../../../class/sound | `-- uevent |-- pcmC0D2p | |-- dev | |-- device -> ../../card0 | |-- pcm_class | |-- power | |-- subsystem -> ../../../../../../class/sound | `-- uevent |-- pcmC0D3p | |-- dev | |-- device -> ../../card0 | |-- pcm_class | |-- power | |-- subsystem -> ../../../../../../class/sound | `-- uevent |-- power | |-- async | |-- autosuspend_delay_ms | |-- control | |-- runtime_active_kids | |-- runtime_active_time | |-- runtime_enabled | |-- runtime_status | |-- runtime_suspended_time | `-- runtime_usage |-- subsystem -> ../../../../../class/sound `-- uevent !!ALSA Device nodes !!----------------- crw-rw---- 1 root audio 116, 6 Sep 16 00:33 /dev/snd/controlC0 crw-rw---- 1 root audio 116, 2 Sep 16 00:34 /dev/snd/pcmC0D0p crw-rw---- 1 root audio 116, 3 Sep 16 00:33 /dev/snd/pcmC0D1c crw-rw---- 1 root audio 116, 4 Sep 16 00:33 /dev/snd/pcmC0D2p crw-rw---- 1 root audio 116, 5 Sep 16 00:33 /dev/snd/pcmC0D3p crw-rw---- 1 root audio 116, 1 Sep 16 00:20 /dev/snd/seq crw-rw---- 1 root audio 116, 33 Sep 16 00:20 /dev/snd/timer /dev/snd/by-path: total 0 drwxr-xr-x 2 root root 60 Sep 16 00:33 . drwxr-xr-x 3 root root 200 Sep 16 00:33 .. lrwxrwxrwx 1 root root 12 Sep 16 00:33 platform-kbl_rt5663 -> ../controlC0 !!Aplay/Arecord output !!-------------------- APLAY **** List of PLAYBACK Hardware Devices **** card 0: kblrt5663 [kblrt5663], device 0: Audio (*) [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: kblrt5663 [kblrt5663], device 2: Hdmi1 (*) [] Subdevices: 1/1 Subdevice #0: subdevice #0 card 0: kblrt5663 [kblrt5663], device 3: Hdmi2 (*) [] Subdevices: 1/1 Subdevice #0: subdevice #0 ARECORD **** List of CAPTURE Hardware Devices **** card 0: kblrt5663 [kblrt5663], device 1: Audio Record (*) [] Subdevices: 1/1 Subdevice #0: subdevice #0 !!Amixer output !!------------- !!-------Mixer controls for card kblrt5663 Card sysdefault:0 'kblrt5663'/'kblrt5663' Mixer name : '' Components : '' Controls : 43 Simple ctrls : 38 Simple mixer control 'Headphone',0 Capabilities: pvolume Playback channels: Front Left - Front Right Limits: Playback 0 - 23 Mono: Front Left: Playback 23 [100%] [10.50dB] Front Right: Playback 23 [100%] [10.50dB] Simple mixer control 'Headphone Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'ADC',0 Capabilities: cvolume cswitch Capture channels: Front Left - Front Right Limits: Capture 0 - 63 Front Left: Capture 52 [83%] [21.75dB] [on] Front Right: Capture 52 [83%] [21.75dB] [on] Simple mixer control 'ADDA MIXL ADC L',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'ADDA MIXL DAC L',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'ADDA MIXR DAC R',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'DAC',0 Capabilities: pvolume Playback channels: Front Left - Front Right Limits: Playback 0 - 87 Mono: Front Left: Playback 67 [77%] [-15.00dB] Front Right: Playback 67 [77%] [-15.00dB] Simple mixer control 'DAC L Mux',0 Capabilities: enum Items: 'DAC L' 'STO DAC MIXL' Item0: 'DAC L' Simple mixer control 'DAC R Mux',0 Capabilities: enum Items: 'DAC R' 'STO DAC MIXR' Item0: 'DAC R' Simple mixer control 'Headset Mic',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'IF1 ADC Data Swap',0 Capabilities: enum Items: 'L/R' 'R/L' 'L/L' 'R/R' Item0: 'L/R' Simple mixer control 'IN1',0 Capabilities: cvolume cvolume-joined Capture channels: Mono Limits: Capture 0 - 8 Mono: Capture 0 [0%] [0.00dB] Simple mixer control 'Pin5-Port0 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin5-Port1 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin5-Port2 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin6-Port0 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin6-Port1 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin6-Port2 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin7-Port0 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin7-Port1 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'Pin7-Port2 Mux',0 Capabilities: enum Items: 'NONE' 'cvt 2' 'cvt 3' 'cvt 4' Item0: 'NONE' Simple mixer control 'STO1 ADC MIXL ADC1',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'STO1 ADC MIXL ADC2',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'STO1 DAC MIXL DAC L',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'STO1 DAC MIXR DAC R',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'codec1_out mo codec0_in mi',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'codec1_out mo media0_in mi',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'hif5-0 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif5-1 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif5-2 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif6-0 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif6-1 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif6-2 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif7-0 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif7-1 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'hif7-2 Jack',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] Simple mixer control 'media0_out mo codec0_in mi',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [on] Simple mixer control 'media0_out mo media0_in mi',0 Capabilities: pswitch pswitch-joined Playback channels: Mono Mono: Playback [off] !!Alsactl output !!-------------- --startcollapse-- state.kblrt5663 { control.1 { iface MIXER name 'IN1 Capture Volume' value 0 comment { access 'read write' type INTEGER count 1 range '0 - 8' dbmin 0 dbmax 5200 dbvalue.0 0 } } control.2 { iface MIXER name 'IF1 ADC Data Swap' value L/R comment { access 'read write' type ENUMERATED count 1 item.0 L/R item.1 R/L item.2 L/L item.3 R/R } } control.3 { iface MIXER name 'Headphone Playback Volume' value.0 23 value.1 23 comment { access 'read write' type INTEGER count 2 range '0 - 23' dbmin -2400 dbmax 1050 dbvalue.0 1050 dbvalue.1 1050 } } control.4 { iface MIXER name 'DAC Playback Volume' value.0 67 value.1 67 comment { access 'read write' type INTEGER count 2 range '0 - 87' dbmin -6525 dbmax 0 dbvalue.0 -1500 dbvalue.1 -1500 } } control.5 { iface MIXER name 'ADC Capture Switch' value.0 true value.1 true comment { access 'read write' type BOOLEAN count 2 } } control.6 { iface MIXER name 'ADC Capture Volume' value.0 52 value.1 52 comment { access 'read write' type INTEGER count 2 range '0 - 63' dbmin -1725 dbmax 3000 dbvalue.0 2175 dbvalue.1 2175 } } control.7 { iface MIXER name 'media0_out mo media0_in mi Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.8 { iface MIXER name 'media0_out mo codec0_in mi Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.9 { iface MIXER name 'codec1_out mo media0_in mi Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.10 { iface MIXER name 'codec1_out mo codec0_in mi Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.11 { iface MIXER name 'STO1 ADC MIXL ADC1 Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.12 { iface MIXER name 'STO1 ADC MIXL ADC2 Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.13 { iface MIXER name 'ADDA MIXL ADC L Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.14 { iface MIXER name 'ADDA MIXL DAC L Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.15 { iface MIXER name 'ADDA MIXR DAC R Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.16 { iface MIXER name 'STO1 DAC MIXL DAC L Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.17 { iface MIXER name 'STO1 DAC MIXR DAC R Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.18 { iface MIXER name 'DAC L Mux' value 'DAC L' comment { access 'read write' type ENUMERATED count 1 item.0 'DAC L' item.1 'STO DAC MIXL' } } control.19 { iface MIXER name 'DAC R Mux' value 'DAC R' comment { access 'read write' type ENUMERATED count 1 item.0 'DAC R' item.1 'STO DAC MIXR' } } control.20 { iface MIXER name 'Pin5-Port0 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.21 { iface MIXER name 'Pin5-Port1 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.22 { iface MIXER name 'Pin5-Port2 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.23 { iface MIXER name 'Pin6-Port0 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.24 { iface MIXER name 'Pin6-Port1 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.25 { iface MIXER name 'Pin6-Port2 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.26 { iface MIXER name 'Pin7-Port0 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.27 { iface MIXER name 'Pin7-Port1 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.28 { iface MIXER name 'Pin7-Port2 Mux' value NONE comment { access 'read write' type ENUMERATED count 1 item.0 NONE item.1 'cvt 2' item.2 'cvt 3' item.3 'cvt 4' } } control.29 { iface MIXER name 'Headphone Jack Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.30 { iface MIXER name 'Headset Mic Switch' value true comment { access 'read write' type BOOLEAN count 1 } } control.31 { iface PCM device 2 name 'Playback Channel Map' value.0 0 value.1 0 value.2 0 value.3 0 value.4 0 value.5 0 value.6 0 value.7 0 comment { access 'read write' type INTEGER count 8 range '0 - 36' } } control.32 { iface PCM device 2 name ELD value '' comment { access 'read volatile' type BYTES count 0 } } control.33 { iface PCM device 3 name 'Playback Channel Map' value.0 0 value.1 0 value.2 0 value.3 0 value.4 0 value.5 0 value.6 0 value.7 0 comment { access 'read write' type INTEGER count 8 range '0 - 36' } } control.34 { iface PCM device 3 name ELD value '' comment { access 'read volatile' type BYTES count 0 } } control.35 { iface MIXER name 'hif5-0 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.36 { iface MIXER name 'hif5-1 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.37 { iface MIXER name 'hif5-2 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.38 { iface MIXER name 'hif6-0 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.39 { iface MIXER name 'hif6-1 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.40 { iface MIXER name 'hif6-2 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.41 { iface MIXER name 'hif7-0 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.42 { iface MIXER name 'hif7-1 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } control.43 { iface MIXER name 'hif7-2 Jack Switch' value false comment { access 'read write' type BOOLEAN count 1 } } } --endcollapse-- !!All Loaded Modules !!------------------ ac acpi_als acpi_thermal_rel aes_generic aesni_intel af_alg algif_hash algif_skcipher ansi_cprng async_memcpy async_pq async_raid6_recov async_tx async_xor autofs4 battery binfmt_misc blake2b_generic bluetooth bnep br_netfilter bridge btbcm btintel btrfs btrtl btusb button ccm cec cfg80211 cmac configfs coretemp cpufreq_conservative cpufreq_ondemand cpufreq_powersave cpufreq_userspace cqhci crc16 crc32_pclmul crc32c_generic crc32c_intel crc_t10dif crct10dif_common crct10dif_generic crct10dif_pclmul cryptd crypto_simd ctr dm_mod drbg drm drm_kms_helper dw_dmac dw_dmac_core ecc ecdh_generic ee1004 evdev ext4 fuse ghash_clmulni_intel glue_helper hid hid_generic i2c_algo_bit i2c_dev i2c_i801 i2c_smbus i915 iTCO_vendor_support iTCO_wdt idma64 industrialio int3400_thermal int3403_thermal int340x_thermal_zone intel_cstate intel_lpss intel_lpss_pci intel_pch_thermal intel_pmc_bxt intel_pmc_core intel_powerclamp intel_rapl_common intel_rapl_msr intel_soc_dts_iosf intel_uncore intel_xhci_usb_role_switch ip_tables ipmi_devintf ipmi_msghandler irqbypass iwlmvm iwlwifi jbd2 jitterentropy_rng joydev kfifo_buf kvm kvm_intel libaes libarc4 libcrc32c libphy linear llc lp mac80211 mbcache md_mod mdio_devres mmc_core msr multipath nf_conntrack nf_conntrack_netlink nf_defrag_ipv4 nf_defrag_ipv6 nf_nat nf_tables nfnetlink nft_chain_nat nft_compat nft_counter ns overlay parport parport_pc pcspkr ppdev processor_thermal_device qrtr r8169 raid0 raid1 raid10 raid456 raid6_pq rapl realtek rfcomm rfkill rng_core roles scsi_mod sd_mod sdhci sdhci_pci sg snd snd_compress snd_hda_codec snd_hda_core snd_hda_ext_core snd_hwdep snd_intel_dspcfg snd_pcm snd_soc_acpi snd_soc_acpi_intel_match snd_soc_core snd_soc_dmic snd_soc_hdac_hda snd_soc_hdac_hdmi snd_soc_kbl_rt5663_max98927 snd_soc_kbl_rt5663_rt5514_max98927 snd_soc_rl6231 snd_soc_rt5663 snd_soc_skl snd_soc_skl_ssp_clk snd_soc_sst_dsp snd_soc_sst_ipc snd_timer soundcore soundwire_bus soundwire_cadence soundwire_generic_allocation soundwire_intel spi_pxa2xx_platform stp t10_pi tpm tpm_tis_core tpm_tis_spi uas usb_common usb_storage usbcore usbhid vboxdrv vboxnetadp vboxnetflt video watchdog x86_pkg_temp_thermal x_tables xfrm_algo xfrm_user xhci_hcd xhci_pci xor xt_MASQUERADE xt_addrtype xt_conntrack !!ALSA/HDA dmesg !!-------------- [ 820.253530] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:System Pin [ 820.253535] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: skl_pcm_open: System Pin [ 820.253543] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: stream tag set in dma params=1 [ 820.253547] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 820.254010] snd_soc_core:dpcm_be_dai_hw_params: SSP1-Codec: ASoC: hw_params BE SSP1-Codec [ 820.254022] snd_soc_core:dapm_update_dai_unlocked: rt5663 i2c-10EC5663:00: Update DAI routes for rt5663-aif playback [ 820.254026] snd_soc_core:dapm_update_dai_chan: rt5663 i2c-10EC5663:00: Connecting DAI route AIF Playback -> AIFRX [ 820.254031] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: Input configuration [ 820.254035] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: ch=2 fmt=24 s_rate=48000 [ 820.254039] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 [ 820.254042] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: bits_per_sample=32 [ 820.254046] snd_soc_skl:skl_get_ep_blob: snd_soc_skl 0000:00:1f.3: endpoint count =2 [ 820.254050] snd_soc_skl:skl_check_ep_match: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0 dev_type = 4 [ 820.254053] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: Format count =1 [ 820.254057] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: ch=2 fmt=32 s_rate=48000 [ 820.254061] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for SSP1 Pin playback [ 820.254065] snd_soc_core:dapm_update_dai_chan: snd_soc_skl 0000:00:1f.3: Connecting DAI route codec1_out -> ssp1 Tx [ 820.254070] snd_soc_core:dpcm_fe_dai_hw_params: Kbl Audio Port: ASoC: hw_params FE Kbl Audio Port rate 48000 chan 2 fmt 2 [ 820.254074] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_params: System Pin [ 820.254078] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: format_val, rate=0, ch=0, format=0 [ 820.254082] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: dma_id=0 [ 820.254085] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 820.254089] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for System Pin playback [ 820.254125] snd_soc_core:dpcm_fe_dai_prepare: Kbl Audio Port: ASoC: prepare FE Kbl Audio Port [ 820.254129] snd_soc_core:dpcm_be_dai_prepare: SSP1-Codec: ASoC: prepare BE SSP1-Codec [ 820.265766] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 820.265775] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 820.266010] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 820.266017] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 820.266021] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 820.266076] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 820.266085] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 820.266319] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 820.266326] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 820.266330] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 820.270510] snd_soc_skl:skl_pcm_prepare: snd_soc_skl 0000:00:1f.3: skl_pcm_prepare: System Pin [ 820.270517] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 820.270547] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 1 [ 820.270552] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285278210 [ 820.270894] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 820.270900] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.270905] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 820.270958] snd_soc_skl:skl_pcm_host_dma_prepare: snd_soc_skl 0000:00:1f.3: format_val=17, rate=48000, ch=2, format=2 [ 820.270985] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 820.270991] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 820.270995] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=0 [ 820.271000] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=10 valid_bd=10 ch_config=1 [ 820.271005] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 820.271009] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 84 bytes [ 820.271014] Module params:00000000: 00000000 000000c0 00000180 00000000 -- [ 820.271036] Param data:80 bb 00 00 10 [ 820.271040] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000003 ext=10015 [ 820.271335] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 820.271342] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10015 [ 820.271346] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 820.271397] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 820.271404] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 820.271409] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 1 instance=0 [ 820.271414] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 820.271418] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=1 config size: 40 bytes [ 820.271422] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 820.271431] Param data:00 00 00 00 80 01 00 00 80 01 [ 820.271434] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000001 ext=1000a [ 820.271667] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 820.271677] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1000a [ 820.271685] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 820.271744] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 820.271751] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 820.271755] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 820.271760] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 820.271764] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000003 ext=1 [ 820.271966] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 820.271972] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 820.271977] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 820.272028] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 4 [ 820.272034] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285474818 [ 820.272359] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 820.272366] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.272370] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 820.272419] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 820.272427] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 820.272431] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 2 instance=0 [ 820.272436] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 820.272440] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=2 config size: 40 bytes [ 820.272445] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 820.272454] Param data:00 00 00 00 80 01 00 00 80 01 [ 820.272457] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000002 ext=4000a [ 820.272700] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 820.272707] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4000a [ 820.272711] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 820.272768] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 5 [ 820.272776] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=1 [ 820.272781] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=18 ch_config=1 [ 820.272786] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 820.272790] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 184 bytes [ 820.272795] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 820.272837] Param data:00 00 00 00 02 18 00 00 80 bb 00 00 20 00 [ 820.272841] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40010003 ext=4002e [ 820.273162] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 820.273169] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4002e [ 820.273173] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 820.273224] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 820.273231] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 820.273235] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 820.273239] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 820.273243] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000002 ext=10003 [ 820.273442] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 820.273449] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 820.273453] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 820.273503] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: sink widget=codec1_out mo [ 820.273509] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: src widget=media0_in mi [ 820.273514] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: src widget=media0_in mi [ 820.273519] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: sink widget=codec1_out mo [ 820.273523] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 820.273527] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 820.273531] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 3 [ 820.273535] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 820.273539] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000001 ext=2 [ 820.273742] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 820.273749] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 820.273753] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 820.273802] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 4 [ 820.273808] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 820.273813] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 820.274046] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 820.274052] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.274057] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 820.274117] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 820.274125] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029252 [ 820.274293] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 820.274298] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.274302] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 820.274354] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 1 dir 0 [ 820.274583] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 1 [ 820.274589] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: post trigger FE Kbl Audio Port cmd 1 [ 820.274594] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 820.274602] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 1 [ 820.274605] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 820.274609] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 820.274801] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 820.274805] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.274809] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 820.274812] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 820.274967] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 820.274972] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.274975] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 820.274979] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 820.275077] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 820.275083] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.275087] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 820.275145] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 820.275152] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832644 [ 820.275366] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 820.275373] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.275377] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 820.275797] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 820.275805] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.275811] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 820.275818] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 820.276057] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 820.276065] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 820.276071] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 820.276077] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 821.771248] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: pre trigger FE Kbl Audio Port cmd 0 [ 821.771259] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 821.771264] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 821.771268] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 821.771272] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 821.771475] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.771479] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.771483] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.771500] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 0 [ 821.771630] snd_soc_core:dpcm_fe_dai_hw_free: Kbl Audio Port: ASoC: hw_free FE Kbl Audio Port [ 821.771640] snd_soc_skl:skl_pcm_hw_free: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_free: System Pin [ 821.771645] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 821.771649] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 821.771653] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 821.771812] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.771817] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.771822] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.771874] snd_soc_core:dpcm_be_dai_hw_free: SSP1-Codec: ASoC: hw_free BE SSP1-Codec [ 821.771909] snd_soc_core:dpcm_be_dai_shutdown: SSP1-Codec: ASoC: close BE SSP1-Codec [ 821.771942] snd_soc_core:dpcm_fe_dai_shutdown: Kbl Audio Port: ASoC: close FE Kbl Audio Port [ 821.771947] snd_soc_skl:skl_pcm_close: snd_soc_skl 0000:00:1f.3: skl_pcm_close: System Pin [ 821.771955] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 821.771961] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 2 dir 0 [ 821.772086] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 821.772094] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 821.772099] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 821.772311] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.772318] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.772322] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.772372] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 821.772379] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 821.772383] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 3 [ 821.772389] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000001 ext=2 [ 821.772601] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 821.772608] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 821.772612] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 821.773819] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=4 [ 821.773825] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 821.773830] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 821.774194] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.774200] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.774205] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.774258] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 821.774265] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 821.774270] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 821.774275] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000002 ext=10003 [ 821.774470] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 821.774477] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 821.774481] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 821.774531] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 4 [ 821.774538] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 821.774542] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029250 [ 821.774745] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.774753] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.774758] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.774796] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302252032 [ 821.775080] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 821.775087] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.775091] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 821.775130] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 821.775135] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 821.775142] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 821.775146] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 821.775149] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 821.775154] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000003 ext=1 [ 821.775295] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 821.775299] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 821.775303] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 821.775336] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 1 [ 821.775341] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 821.775346] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 821.775506] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 821.775511] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.775516] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 821.775548] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302055424 [ 821.775791] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 821.775799] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 821.775805] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 821.775858] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 821.775865] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 1 [ 821.776933] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 821.776940] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 821.777149] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 821.777157] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 821.777163] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 821.777176] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 821.777182] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 821.777387] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 821.777394] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 821.777398] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 821.788922] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: ASoC: BE playback disconnect check for SSP1-Codec [ 821.788928] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: freed DSP playback path Kbl Audio Port -> SSP1-Codec [ 827.023979] snd_soc_core:snd_soc_close_delayed_work: Kbl Audio Port: ASoC: pop wq checking: Playback status: inactive waiting: yes [ 842.671048] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget System Playback [ 842.671058] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671063] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671067] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671071] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671075] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671079] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671082] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in cpr 0 [ 842.671086] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671089] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671093] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671096] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671099] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671103] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671106] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in mi [ 842.671110] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671113] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671117] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671120] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671123] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671127] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671130] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out mo [ 842.671134] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671137] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671140] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671144] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671147] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671150] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671154] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out cpr 5 [ 842.671158] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671161] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671164] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671168] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671171] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671174] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671178] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out [ 842.671181] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671185] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 842.671188] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 842.671192] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 842.671195] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 842.671198] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 842.671202] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 842.671205] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671211] snd_soc_core:dpcm_path_get: Kbl Audio Port: ASoC: found 8 audio playback paths [ 842.671215] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 842.671218] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 842.671223] snd_soc_core:dpcm_be_connect: Kbl Audio Port: connected new DPCM playback path Kbl Audio Port -> SSP1-Codec [ 842.671233] snd_soc_core:dpcm_add_paths: Kbl Audio Port: ASoC: found 1 new BE paths [ 842.671237] snd_soc_core:dpcm_be_dai_startup: SSP1-Codec: ASoC: open playback BE SSP1-Codec [ 842.671244] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:SSP1 Pin [ 842.671249] snd_soc_core:dpcm_fe_dai_startup: Kbl Audio Port: ASoC: open FE Kbl Audio Port [ 842.671253] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:System Pin [ 842.671258] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: skl_pcm_open: System Pin [ 842.671266] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: stream tag set in dma params=1 [ 842.671271] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 842.671731] snd_soc_core:dpcm_be_dai_hw_params: SSP1-Codec: ASoC: hw_params BE SSP1-Codec [ 842.671742] snd_soc_core:dapm_update_dai_unlocked: rt5663 i2c-10EC5663:00: Update DAI routes for rt5663-aif playback [ 842.671747] snd_soc_core:dapm_update_dai_chan: rt5663 i2c-10EC5663:00: Connecting DAI route AIF Playback -> AIFRX [ 842.671752] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: Input configuration [ 842.671756] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: ch=2 fmt=24 s_rate=48000 [ 842.671760] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 [ 842.671763] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: bits_per_sample=32 [ 842.671767] snd_soc_skl:skl_get_ep_blob: snd_soc_skl 0000:00:1f.3: endpoint count =2 [ 842.671770] snd_soc_skl:skl_check_ep_match: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0 dev_type = 4 [ 842.671774] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: Format count =1 [ 842.671778] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: ch=2 fmt=32 s_rate=48000 [ 842.671782] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for SSP1 Pin playback [ 842.671786] snd_soc_core:dapm_update_dai_chan: snd_soc_skl 0000:00:1f.3: Connecting DAI route codec1_out -> ssp1 Tx [ 842.671791] snd_soc_core:dpcm_fe_dai_hw_params: Kbl Audio Port: ASoC: hw_params FE Kbl Audio Port rate 48000 chan 2 fmt 2 [ 842.671795] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_params: System Pin [ 842.671799] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: format_val, rate=0, ch=0, format=0 [ 842.671802] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: dma_id=0 [ 842.671806] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 842.671810] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for System Pin playback [ 842.671845] snd_soc_core:dpcm_fe_dai_prepare: Kbl Audio Port: ASoC: prepare FE Kbl Audio Port [ 842.671849] snd_soc_core:dpcm_be_dai_prepare: SSP1-Codec: ASoC: prepare BE SSP1-Codec [ 842.683359] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 842.683366] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 842.683607] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 842.683614] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 842.683618] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 842.683672] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 842.683679] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 842.683900] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 842.683906] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 842.683911] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 842.688333] snd_soc_skl:skl_pcm_prepare: snd_soc_skl 0000:00:1f.3: skl_pcm_prepare: System Pin [ 842.688340] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 842.688359] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 1 [ 842.688363] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285278210 [ 842.688676] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 842.688683] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.688687] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 842.688739] snd_soc_skl:skl_pcm_host_dma_prepare: snd_soc_skl 0000:00:1f.3: format_val=17, rate=48000, ch=2, format=2 [ 842.688766] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 842.688771] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 842.688776] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=0 [ 842.688781] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=10 valid_bd=10 ch_config=1 [ 842.688785] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 842.688789] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 84 bytes [ 842.688794] Module params:00000000: 00000000 000000c0 00000180 00000000 -- [ 842.688815] Param data:80 bb 00 00 10 [ 842.688818] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000003 ext=10015 [ 842.689112] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 842.689119] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10015 [ 842.689124] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 842.689173] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 842.689180] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 842.689184] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 1 instance=0 [ 842.689189] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 842.689194] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=1 config size: 40 bytes [ 842.689199] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 842.689208] Param data:00 00 00 00 80 01 00 00 80 01 [ 842.689211] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000001 ext=1000a [ 842.689443] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 842.689450] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1000a [ 842.689454] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 842.689504] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 842.689511] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 842.689515] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 842.689519] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 842.689523] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000003 ext=1 [ 842.689722] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 842.689729] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 842.689733] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 842.689784] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 4 [ 842.689790] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285474818 [ 842.690097] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 842.690104] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.690108] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 842.690159] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 842.690167] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 842.690171] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 2 instance=0 [ 842.690176] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 842.690180] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=2 config size: 40 bytes [ 842.690185] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 842.690194] Param data:00 00 00 00 80 01 00 00 80 01 [ 842.690198] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000002 ext=4000a [ 842.690440] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 842.690446] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4000a [ 842.690451] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 842.690503] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 5 [ 842.690510] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=1 [ 842.690516] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=18 ch_config=1 [ 842.690520] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 842.690524] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 184 bytes [ 842.690529] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 842.690571] Param data:00 00 00 00 02 18 00 00 80 bb 00 00 20 00 [ 842.690574] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40010003 ext=4002e [ 842.690923] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 842.690930] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4002e [ 842.690934] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 842.690972] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 842.690978] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 842.690982] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 842.690986] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 842.690990] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000002 ext=10003 [ 842.691184] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 842.691191] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 842.691195] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 842.691231] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: sink widget=codec1_out mo [ 842.691235] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: src widget=media0_in mi [ 842.691240] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: src widget=media0_in mi [ 842.691244] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: sink widget=codec1_out mo [ 842.691248] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 842.691251] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 842.691255] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 3 [ 842.691259] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 842.691263] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000001 ext=2 [ 842.691461] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 842.691468] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 842.691472] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 842.691523] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 4 [ 842.691529] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 842.691534] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 842.691767] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 842.691773] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.691778] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 842.691831] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 842.691838] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029252 [ 842.692005] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 842.692010] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.692014] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 842.692051] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 1 dir 0 [ 842.692461] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 1 [ 842.692468] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: post trigger FE Kbl Audio Port cmd 1 [ 842.692472] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 842.692481] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 1 [ 842.692489] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 842.692495] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 842.692676] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 842.692681] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.692685] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 842.692719] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 842.692724] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832644 [ 842.692851] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 842.692855] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.692859] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 842.692863] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 842.692959] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 842.692963] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.692967] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 842.692970] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 842.693066] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 842.693070] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.693074] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 842.693812] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 842.693817] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.693821] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 842.693824] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 842.694072] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 842.694077] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 842.694082] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 842.694085] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 844.189244] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: pre trigger FE Kbl Audio Port cmd 0 [ 844.189255] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 844.189260] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 844.189264] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 844.189268] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 844.189492] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.189500] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.189505] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.189528] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 0 [ 844.189654] snd_soc_core:dpcm_fe_dai_hw_free: Kbl Audio Port: ASoC: hw_free FE Kbl Audio Port [ 844.189662] snd_soc_skl:skl_pcm_hw_free: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_free: System Pin [ 844.189667] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 844.189672] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 844.189676] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 844.189883] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.189890] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.189894] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.189952] snd_soc_core:dpcm_be_dai_hw_free: SSP1-Codec: ASoC: hw_free BE SSP1-Codec [ 844.189983] snd_soc_core:dpcm_be_dai_shutdown: SSP1-Codec: ASoC: close BE SSP1-Codec [ 844.190016] snd_soc_core:dpcm_fe_dai_shutdown: Kbl Audio Port: ASoC: close FE Kbl Audio Port [ 844.190021] snd_soc_skl:skl_pcm_close: snd_soc_skl 0000:00:1f.3: skl_pcm_close: System Pin [ 844.190028] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 844.190034] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 2 dir 0 [ 844.190201] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 844.190208] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 844.190213] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 844.190427] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.190433] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.190438] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.190500] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 844.190507] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 844.190511] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 3 [ 844.190516] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000001 ext=2 [ 844.190720] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 844.190726] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 844.190731] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 844.192187] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=4 [ 844.192193] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 844.192198] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 844.192517] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.192526] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.192530] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.192586] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 844.192594] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 844.192598] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 844.192603] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000002 ext=10003 [ 844.192826] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 844.192834] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 844.192838] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 844.192888] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 4 [ 844.192895] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 844.192899] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029250 [ 844.193108] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.193115] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.193119] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.193170] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302252032 [ 844.193446] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 844.193453] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.193457] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 844.193508] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 844.193515] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 844.193524] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 844.193528] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 844.193532] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 844.193537] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000003 ext=1 [ 844.193731] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 844.193737] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 844.193741] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 844.193798] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 1 [ 844.193806] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 844.193810] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 844.194018] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 844.194024] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.194029] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 844.194082] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302055424 [ 844.194274] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 844.194279] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 844.194283] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 844.194333] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 844.194341] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 1 [ 844.195405] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 844.195411] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 844.195578] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 844.195582] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 844.195586] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 844.195622] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 844.195627] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 844.195866] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 844.195873] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 844.195877] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 844.207315] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: ASoC: BE playback disconnect check for SSP1-Codec [ 844.207322] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: freed DSP playback path Kbl Audio Port -> SSP1-Codec [ 845.443899] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget System Playback [ 845.443910] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.443914] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.443918] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.443922] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.443926] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.443929] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.443933] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in cpr 0 [ 845.443937] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.443940] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.443944] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.443947] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.443950] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.443954] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.443957] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in mi [ 845.443961] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.443964] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.443968] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.443971] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.443974] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.443978] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.443981] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out mo [ 845.443985] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.443988] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.443991] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.443995] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.443998] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.444001] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.444005] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out cpr 5 [ 845.444009] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.444012] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.444015] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.444019] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.444022] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.444025] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.444029] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out [ 845.444032] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.444036] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 845.444039] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 845.444043] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 845.444046] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 845.444049] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 845.444053] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 845.444056] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.444062] snd_soc_core:dpcm_path_get: Kbl Audio Port: ASoC: found 8 audio playback paths [ 845.444065] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 845.444069] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 845.444074] snd_soc_core:dpcm_be_connect: Kbl Audio Port: connected new DPCM playback path Kbl Audio Port -> SSP1-Codec [ 845.444084] snd_soc_core:dpcm_add_paths: Kbl Audio Port: ASoC: found 1 new BE paths [ 845.444088] snd_soc_core:dpcm_be_dai_startup: SSP1-Codec: ASoC: open playback BE SSP1-Codec [ 845.444095] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:SSP1 Pin [ 845.444101] snd_soc_core:dpcm_fe_dai_startup: Kbl Audio Port: ASoC: open FE Kbl Audio Port [ 845.444106] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:System Pin [ 845.444110] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: skl_pcm_open: System Pin [ 845.444118] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: stream tag set in dma params=1 [ 845.444122] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 845.444810] snd_soc_core:dpcm_be_dai_hw_params: SSP1-Codec: ASoC: hw_params BE SSP1-Codec [ 845.444828] snd_soc_core:dapm_update_dai_unlocked: rt5663 i2c-10EC5663:00: Update DAI routes for rt5663-aif playback [ 845.444835] snd_soc_core:dapm_update_dai_chan: rt5663 i2c-10EC5663:00: Connecting DAI route AIF Playback -> AIFRX [ 845.444845] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: Input configuration [ 845.444852] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: ch=2 fmt=24 s_rate=48000 [ 845.444858] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 [ 845.444865] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: bits_per_sample=32 [ 845.444872] snd_soc_skl:skl_get_ep_blob: snd_soc_skl 0000:00:1f.3: endpoint count =2 [ 845.444880] snd_soc_skl:skl_check_ep_match: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0 dev_type = 4 [ 845.444887] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: Format count =1 [ 845.444894] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: ch=2 fmt=32 s_rate=48000 [ 845.444901] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for SSP1 Pin playback [ 845.444909] snd_soc_core:dapm_update_dai_chan: snd_soc_skl 0000:00:1f.3: Connecting DAI route codec1_out -> ssp1 Tx [ 845.444917] snd_soc_core:dpcm_fe_dai_hw_params: Kbl Audio Port: ASoC: hw_params FE Kbl Audio Port rate 48000 chan 2 fmt 2 [ 845.444925] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_params: System Pin [ 845.444933] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: format_val, rate=0, ch=0, format=0 [ 845.444940] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: dma_id=0 [ 845.444946] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 845.444953] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for System Pin playback [ 845.444998] snd_soc_core:dpcm_fe_dai_prepare: Kbl Audio Port: ASoC: prepare FE Kbl Audio Port [ 845.445004] snd_soc_core:dpcm_be_dai_prepare: SSP1-Codec: ASoC: prepare BE SSP1-Codec [ 845.456562] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 845.456572] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 845.456838] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 845.456846] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 845.456850] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 845.456873] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 845.456883] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 845.457131] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 845.457138] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 845.457142] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 845.461259] snd_soc_skl:skl_pcm_prepare: snd_soc_skl 0000:00:1f.3: skl_pcm_prepare: System Pin [ 845.461268] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 845.461294] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 1 [ 845.461302] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285278210 [ 845.461615] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 845.461622] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.461626] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 845.461648] snd_soc_skl:skl_pcm_host_dma_prepare: snd_soc_skl 0000:00:1f.3: format_val=17, rate=48000, ch=2, format=2 [ 845.461681] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 845.461689] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 845.461695] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=0 [ 845.461704] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=10 valid_bd=10 ch_config=1 [ 845.461710] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 845.461721] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 84 bytes [ 845.461729] Module params:00000000: 00000000 000000c0 00000180 00000000 -- [ 845.461761] Param data:80 bb 00 00 10 [ 845.461767] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000003 ext=10015 [ 845.462063] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 845.462070] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10015 [ 845.462074] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 845.462093] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 845.462103] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 845.462110] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 1 instance=0 [ 845.462117] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 845.462124] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=1 config size: 40 bytes [ 845.462132] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 845.462147] Param data:00 00 00 00 80 01 00 00 80 01 [ 845.462153] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000001 ext=1000a [ 845.462387] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 845.462394] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1000a [ 845.462398] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 845.462417] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 845.462426] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 845.462432] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 845.462439] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 845.462446] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000003 ext=1 [ 845.462651] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 845.462657] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 845.462662] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 845.462680] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 4 [ 845.462689] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285474818 [ 845.462980] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 845.462987] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.462991] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 845.463008] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 845.463018] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 845.463024] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 2 instance=0 [ 845.463031] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 845.463037] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=2 config size: 40 bytes [ 845.463044] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 845.463058] Param data:00 00 00 00 80 01 00 00 80 01 [ 845.463064] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000002 ext=4000a [ 845.463306] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 845.463312] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4000a [ 845.463317] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 845.463338] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 5 [ 845.463346] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=1 [ 845.463353] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=18 ch_config=1 [ 845.463360] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 845.463367] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 184 bytes [ 845.463374] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 845.463448] Param data:00 00 00 00 02 18 00 00 80 bb 00 00 20 00 [ 845.463455] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40010003 ext=4002e [ 845.463776] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 845.463783] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4002e [ 845.463787] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 845.463808] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 845.463817] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 845.463824] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 845.463830] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 845.463836] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000002 ext=10003 [ 845.464052] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 845.464059] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 845.464063] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 845.464080] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: sink widget=codec1_out mo [ 845.464088] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: src widget=media0_in mi [ 845.464095] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: src widget=media0_in mi [ 845.464101] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: sink widget=codec1_out mo [ 845.464107] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 845.464114] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 845.464121] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 3 [ 845.464128] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 845.464134] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000001 ext=2 [ 845.464303] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 845.464308] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 845.464312] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 845.464325] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 4 [ 845.464356] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 845.464367] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 845.464556] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 845.464561] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.464565] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 845.464580] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 845.464592] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029252 [ 845.464784] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.464789] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.464792] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.464796] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 845.464895] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.464899] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.464902] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.464906] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 845.465003] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 845.465007] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.465011] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 845.465029] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 1 dir 0 [ 845.465625] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 1 [ 845.465634] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: post trigger FE Kbl Audio Port cmd 1 [ 845.465641] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 845.465653] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 1 [ 845.465660] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 845.465667] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 845.465791] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.465798] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.465802] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.465805] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 845.465904] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.465908] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.465912] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.465915] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 845.466009] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 845.466013] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.466017] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 845.466036] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 845.466044] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832644 [ 845.466190] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 845.466195] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.466199] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 845.466815] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.466820] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.466823] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.466827] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 845.467122] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 845.467128] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 845.467132] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 845.467136] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 846.962272] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: pre trigger FE Kbl Audio Port cmd 0 [ 846.962283] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 846.962288] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 846.962292] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 846.962297] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 846.962520] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.962528] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.962533] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.962555] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 0 [ 846.962687] snd_soc_core:dpcm_fe_dai_hw_free: Kbl Audio Port: ASoC: hw_free FE Kbl Audio Port [ 846.962696] snd_soc_skl:skl_pcm_hw_free: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_free: System Pin [ 846.962701] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 846.962706] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 846.962710] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 846.962910] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.962916] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.962921] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.962976] snd_soc_core:dpcm_be_dai_hw_free: SSP1-Codec: ASoC: hw_free BE SSP1-Codec [ 846.963007] snd_soc_core:dpcm_be_dai_shutdown: SSP1-Codec: ASoC: close BE SSP1-Codec [ 846.963039] snd_soc_core:dpcm_fe_dai_shutdown: Kbl Audio Port: ASoC: close FE Kbl Audio Port [ 846.963044] snd_soc_skl:skl_pcm_close: snd_soc_skl 0000:00:1f.3: skl_pcm_close: System Pin [ 846.963051] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 846.963058] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 2 dir 0 [ 846.963205] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 846.963211] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 846.963215] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 846.963425] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.963431] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.963436] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.963497] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 846.963503] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 846.963507] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 3 [ 846.963512] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000001 ext=2 [ 846.963713] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 846.963719] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 846.963724] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 846.964863] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=4 [ 846.964873] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 846.964880] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 846.965216] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.965223] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.965227] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.965249] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 846.965259] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 846.965266] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 846.965273] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000002 ext=10003 [ 846.965475] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 846.965482] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 846.965487] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 846.965506] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 4 [ 846.965515] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 846.965522] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029250 [ 846.965740] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.965747] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.965753] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.965770] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302252032 [ 846.965972] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 846.965976] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.965980] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 846.965995] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 846.966003] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 846.966012] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 846.966019] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 846.966025] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 846.966032] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000003 ext=1 [ 846.966232] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 846.966239] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 846.966244] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 846.966260] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 1 [ 846.966269] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 846.966275] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 846.966413] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 846.966417] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.966421] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 846.966435] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302055424 [ 846.966607] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 846.966611] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 846.966615] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 846.966627] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 846.966636] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 1 [ 846.967632] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 846.967642] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 846.967812] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 846.967816] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 846.967820] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 846.967836] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 846.967845] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 846.968017] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 846.968021] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 846.968025] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 846.979386] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: ASoC: BE playback disconnect check for SSP1-Codec [ 846.979396] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: freed DSP playback path Kbl Audio Port -> SSP1-Codec [ 852.112725] snd_soc_core:snd_soc_close_delayed_work: Kbl Audio Port: ASoC: pop wq checking: Playback status: inactive waiting: yes [ 856.824230] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget System Playback [ 856.824242] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824246] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824250] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824254] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824258] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824262] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824266] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in cpr 0 [ 856.824269] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824273] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824276] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824280] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824283] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824286] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824290] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget media0_in mi [ 856.824293] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824297] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824300] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824303] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824307] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824310] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824314] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out mo [ 856.824317] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824320] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824324] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824327] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824330] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824334] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824337] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out cpr 5 [ 856.824341] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824344] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824348] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824351] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824354] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824358] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824361] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget codec1_out [ 856.824365] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824368] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : AIF Playback [ 856.824371] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp1 Tx [ 856.824375] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi1 [ 856.824378] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : iDisp2 Tx [ 856.824381] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : hifi2 [ 856.824385] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 856.824388] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824395] snd_soc_core:dpcm_path_get: Kbl Audio Port: ASoC: found 8 audio playback paths [ 856.824399] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: find BE for widget ssp1 Tx [ 856.824403] snd_soc_core:dpcm_get_be: kbl_rt5663_m98927 kbl_rt5663: ASoC: try BE : ssp1 Tx [ 856.824407] snd_soc_core:dpcm_be_connect: Kbl Audio Port: connected new DPCM playback path Kbl Audio Port -> SSP1-Codec [ 856.824417] snd_soc_core:dpcm_add_paths: Kbl Audio Port: ASoC: found 1 new BE paths [ 856.824421] snd_soc_core:dpcm_be_dai_startup: SSP1-Codec: ASoC: open playback BE SSP1-Codec [ 856.824428] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:SSP1 Pin [ 856.824434] snd_soc_core:dpcm_fe_dai_startup: Kbl Audio Port: ASoC: open FE Kbl Audio Port [ 856.824438] snd_soc_skl:skl_platform_soc_open: snd_soc_skl 0000:00:1f.3: In skl_platform_soc_open:System Pin [ 856.824443] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: skl_pcm_open: System Pin [ 856.824451] snd_soc_skl:skl_pcm_open: snd_soc_skl 0000:00:1f.3: stream tag set in dma params=1 [ 856.824456] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 856.824955] snd_soc_core:dpcm_be_dai_hw_params: SSP1-Codec: ASoC: hw_params BE SSP1-Codec [ 856.824966] snd_soc_core:dapm_update_dai_unlocked: rt5663 i2c-10EC5663:00: Update DAI routes for rt5663-aif playback [ 856.824971] snd_soc_core:dapm_update_dai_chan: rt5663 i2c-10EC5663:00: Connecting DAI route AIF Playback -> AIFRX [ 856.824977] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: Input configuration [ 856.824981] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: ch=2 fmt=24 s_rate=48000 [ 856.824985] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 [ 856.824988] snd_soc_skl:dump_config: snd_soc_skl 0000:00:1f.3: bits_per_sample=32 [ 856.824991] snd_soc_skl:skl_get_ep_blob: snd_soc_skl 0000:00:1f.3: endpoint count =2 [ 856.824995] snd_soc_skl:skl_check_ep_match: snd_soc_skl 0000:00:1f.3: vbus_id=1 link_type=3 dir=0 dev_type = 4 [ 856.824999] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: Format count =1 [ 856.825003] snd_soc_skl:skl_get_specific_cfg: snd_soc_skl 0000:00:1f.3: ch=2 fmt=32 s_rate=48000 [ 856.825007] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for SSP1 Pin playback [ 856.825011] snd_soc_core:dapm_update_dai_chan: snd_soc_skl 0000:00:1f.3: Connecting DAI route codec1_out -> ssp1 Tx [ 856.825015] snd_soc_core:dpcm_fe_dai_hw_params: Kbl Audio Port: ASoC: hw_params FE Kbl Audio Port rate 48000 chan 2 fmt 2 [ 856.825020] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_params: System Pin [ 856.825024] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: format_val, rate=0, ch=0, format=0 [ 856.825027] snd_soc_skl:skl_pcm_hw_params: snd_soc_skl 0000:00:1f.3: dma_id=0 [ 856.825031] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 856.825035] snd_soc_core:dapm_update_dai_unlocked: snd_soc_skl 0000:00:1f.3: Update DAI routes for System Pin playback [ 856.825072] snd_soc_core:dpcm_fe_dai_prepare: Kbl Audio Port: ASoC: prepare FE Kbl Audio Port [ 856.825076] snd_soc_core:dpcm_be_dai_prepare: SSP1-Codec: ASoC: prepare BE SSP1-Codec [ 856.836699] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 856.836714] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 856.836939] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 856.836946] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 856.836950] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 856.837015] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 856.837022] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 856.837261] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 856.837268] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 856.837272] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 856.841612] snd_soc_skl:skl_pcm_prepare: snd_soc_skl 0000:00:1f.3: skl_pcm_prepare: System Pin [ 856.841619] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 856.841639] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 1 [ 856.841644] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285278210 [ 856.841979] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 856.841986] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.841990] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 856.842044] snd_soc_skl:skl_pcm_host_dma_prepare: snd_soc_skl 0000:00:1f.3: format_val=17, rate=48000, ch=2, format=2 [ 856.842071] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 856.842077] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 856.842081] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=0 [ 856.842086] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=10 valid_bd=10 ch_config=1 [ 856.842091] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 856.842095] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 84 bytes [ 856.842100] Module params:00000000: 00000000 000000c0 00000180 00000000 -- [ 856.842120] Param data:80 bb 00 00 10 [ 856.842124] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000003 ext=10015 [ 856.842418] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 856.842425] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10015 [ 856.842429] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 856.842480] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 856.842487] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 856.842491] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 1 instance=0 [ 856.842496] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 856.842501] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=1 config size: 40 bytes [ 856.842505] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 856.842514] Param data:00 00 00 00 80 01 00 00 80 01 [ 856.842518] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000001 ext=1000a [ 856.842750] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 856.842757] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1000a [ 856.842761] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 856.842815] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 856.842821] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 856.842826] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 856.842830] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 856.842834] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000003 ext=1 [ 856.843034] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 856.843042] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 856.843046] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 856.843099] snd_soc_skl:skl_create_pipeline: snd_soc_skl 0000:00:1f.3: skl_create_pipeline: pipe_id = 4 [ 856.843105] snd_soc_skl:skl_ipc_create_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_create_pipeline header=285474818 [ 856.843428] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b1000000 [ 856.843434] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.843438] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b1000000: success [ 856.843484] snd_soc_skl:skl_tplg_update_be_blob: snd_soc_skl 0000:00:1f.3: Applying default cfg blob [ 856.843490] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 856.843494] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 2 instance=0 [ 856.843498] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=20 ch_config=1 [ 856.843503] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=0 id=2 config size: 40 bytes [ 856.843507] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 856.843516] Param data:00 00 00 00 80 01 00 00 80 01 [ 856.843520] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40000002 ext=4000a [ 856.843760] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 856.843766] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4000a [ 856.843770] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 856.843811] snd_soc_skl:skl_dsp_get_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 5 [ 856.843815] snd_soc_skl:skl_init_module: snd_soc_skl 0000:00:1f.3: skl_init_module: module_id = 3 instance=1 [ 856.843819] snd_soc_skl:skl_set_base_module_format: snd_soc_skl 0000:00:1f.3: bit_depth=20 valid_bd=18 ch_config=1 [ 856.843824] snd_soc_skl:skl_setup_out_format: snd_soc_skl 0000:00:1f.3: copier out format chan=2 fre=48000 bitdepth=32 [ 856.843828] snd_soc_skl:skl_set_module_format: snd_soc_skl 0000:00:1f.3: Module type=1 id=3 config size: 184 bytes [ 856.843832] Module params:00000000: 00000000 00000180 00000180 00000000 -- [ 856.843872] Param data:00 00 00 00 02 18 00 00 80 bb 00 00 20 00 [ 856.843876] snd_soc_skl:skl_ipc_init_instance: snd_soc_skl 0000:00:1f.3: In skl_ipc_init_instance primary =40010003 ext=4002e [ 856.844191] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e0000000 [ 856.844197] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:4002e [ 856.844202] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e0000000: success [ 856.844253] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 856.844260] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 856.844264] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 2 [ 856.844269] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 856.844273] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000002 ext=10003 [ 856.844473] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 856.844480] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 856.844484] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 856.844534] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: sink widget=codec1_out mo [ 856.844541] snd_soc_skl:skl_get_src_dsp_widget: snd_soc_skl 0000:00:1f.3: src widget=media0_in mi [ 856.844547] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: src widget=media0_in mi [ 856.844551] snd_soc_skl:skl_tplg_bind_sinks: snd_soc_skl 0000:00:1f.3: skl_tplg_bind_sinks: sink widget=codec1_out mo [ 856.844555] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 856.844559] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 856.844563] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 2 dst module state = 3 [ 856.844567] snd_soc_skl:skl_bind_modules: snd_soc_skl 0000:00:1f.3: src queue = 0 dst queue =0 [ 856.844571] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=45000001 ext=2 [ 856.844731] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e5000000 [ 856.844736] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 856.844740] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e5000000: success [ 856.844789] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 4 [ 856.844799] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 856.844808] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 856.845035] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 856.845042] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.845047] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 856.845098] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 856.845110] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029252 [ 856.845282] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 856.845287] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.845291] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 856.845341] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 1 dir 0 [ 856.845712] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 1 [ 856.845720] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: post trigger FE Kbl Audio Port cmd 1 [ 856.845725] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 856.845733] snd_soc_skl:skl_run_pipe: snd_soc_skl 0000:00:1f.3: skl_run_pipe: pipe = 1 [ 856.845737] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 856.845741] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 856.845849] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 856.845856] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.845860] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 856.845863] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 856.845968] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 856.845973] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.845976] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 856.845979] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 856.846080] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 856.846084] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.846088] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 856.846138] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 4 [ 856.846145] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832644 [ 856.846307] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 856.846311] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.846314] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 856.846835] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 856.846840] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.846844] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 856.846847] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 856.847142] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:9b050000 [ 856.847149] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 856.847153] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Notification from firmware [ 856.847156] snd_soc_skl 0000:00:1f.3: MCPS Budget Violation: 9b050000 [ 858.342282] snd_soc_core:dpcm_dai_trigger_fe_be: Kbl Audio Port: ASoC: pre trigger FE Kbl Audio Port cmd 0 [ 858.342293] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 858.342298] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 858.342302] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 858.342306] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 858.342528] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.342534] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.342539] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.342558] snd_soc_core:dpcm_do_trigger: SSP1-Codec: ASoC: trigger BE SSP1-Codec cmd 0 [ 858.342682] snd_soc_core:dpcm_fe_dai_hw_free: Kbl Audio Port: ASoC: hw_free FE Kbl Audio Port [ 858.342691] snd_soc_skl:skl_pcm_hw_free: snd_soc_skl 0000:00:1f.3: skl_pcm_hw_free: System Pin [ 858.342695] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 858.342700] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 858.342704] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 858.342906] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.342912] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.342917] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.342975] snd_soc_core:dpcm_be_dai_hw_free: SSP1-Codec: ASoC: hw_free BE SSP1-Codec [ 858.343005] snd_soc_core:dpcm_be_dai_shutdown: SSP1-Codec: ASoC: close BE SSP1-Codec [ 858.343036] snd_soc_core:dpcm_fe_dai_shutdown: Kbl Audio Port: ASoC: close FE Kbl Audio Port [ 858.343041] snd_soc_skl:skl_pcm_close: snd_soc_skl 0000:00:1f.3: skl_pcm_close: System Pin [ 858.343048] snd_soc_skl:skl_tplg_fe_get_cpr_module: snd_soc_skl 0000:00:1f.3: set params for media0_in cpr 0 [ 858.343055] snd_soc_core:dpcm_dapm_stream_event: SSP1-Codec: ASoC: BE SSP1-Codec event 2 dir 0 [ 858.343212] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=1 [ 858.343218] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 858.343223] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832643 [ 858.343434] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.343441] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.343445] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.343504] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 1 src_instance=0 [ 858.343511] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=2 dst_instance=0 [ 858.343515] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 3 [ 858.343520] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000001 ext=2 [ 858.343728] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 858.343734] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:2 [ 858.343739] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 858.345086] snd_soc_skl:skl_stop_pipe: snd_soc_skl 0000:00:1f.3: In skl_stop_pipe pipe=4 [ 858.345093] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 3 [ 858.345098] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029251 [ 858.345434] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.345441] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.345446] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.345500] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 2 src_instance=0 [ 858.345507] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=3 dst_instance=1 [ 858.345511] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 858.345516] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000002 ext=10003 [ 858.345712] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 858.345719] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:10003 [ 858.345724] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 858.345777] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 4 [ 858.345784] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 858.345789] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=319029250 [ 858.345942] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.345946] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.345950] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.346011] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302252032 [ 858.346233] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 858.346238] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.346242] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 858.346289] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 4 [ 858.346296] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 3 [ 858.346304] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: src module_id = 3 src_instance=0 [ 858.346308] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: skl_dump_bind_info: dst_module=1 dst_instance=0 [ 858.346312] snd_soc_skl:skl_dump_bind_info: snd_soc_skl 0000:00:1f.3: src_module state = 3 dst module state = 2 [ 858.346317] snd_soc_skl:skl_ipc_bind_unbind: snd_soc_skl 0000:00:1f.3: In skl_ipc_bind_unbind hdr=46000003 ext=1 [ 858.346513] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e6000000 [ 858.346520] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:1 [ 858.346524] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e6000000: success [ 858.346573] snd_soc_skl:skl_delete_pipe: snd_soc_skl 0000:00:1f.3: skl_delete_pipe: pipe = 1 [ 858.346579] snd_soc_skl:skl_set_pipe_state: snd_soc_skl 0000:00:1f.3: skl_set_pipe_state: pipe_state = 2 [ 858.346584] snd_soc_skl:skl_ipc_set_pipeline_state: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_pipeline_state header=318832642 [ 858.346791] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b3000000 [ 858.346797] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.346802] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b3000000: success [ 858.346850] snd_soc_skl:skl_ipc_delete_pipeline: snd_soc_skl 0000:00:1f.3: In skl_ipc_delete_pipeline header=302055424 [ 858.347094] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:b2000000 [ 858.347100] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:0 [ 858.347105] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply b2000000: success [ 858.347154] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 2 [ 858.347161] snd_soc_skl:skl_dsp_put_core: snd_soc_skl 0000:00:1f.3: core id 0 state 1 usage_count 1 [ 858.348329] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 858.348336] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 858.348558] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 858.348565] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 858.348569] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 858.348608] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: In skl_ipc_set_large_config primary=0x44000000 ext=0x3050007c [ 858.348616] snd_soc_skl:skl_ipc_set_large_config: snd_soc_skl 0000:00:1f.3: transmitting offset: 0x0, size: 0x7c [ 858.348817] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond primary:e4000000 [ 858.348824] snd_soc_skl:skl_dsp_irq_thread_handler: snd_soc_skl 0000:00:1f.3: IPC irq: Firmware respond extension:3050007c [ 858.348831] snd_soc_skl:skl_ipc_process_reply: snd_soc_skl 0000:00:1f.3: ipc FW reply e4000000: success [ 858.360270] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: ASoC: BE playback disconnect check for SSP1-Codec [ 858.360277] snd_soc_core:dpcm_be_disconnect: Kbl Audio Port: freed DSP playback path Kbl Audio Port -> SSP1-Codec [ 863.377106] snd_soc_core:snd_soc_close_delayed_work: Kbl Audio Port: ASoC: pop wq checking: Playback status: inactive waiting: yes !!Packages installed !!-------------------- ii alsa-tools 1.2.5-2 amd64 Console based ALSA utilities for specific hardware ii alsa-topology-conf 1.2.5.1-2 all ALSA topology configuration files ii alsa-ucm-conf 1.2.7.2-1 all ALSA Use Case Manager configuration files ii alsa-utils 1.2.7-1 amd64 Utilities for configuring and using ALSA