kern :notice: [ 0.000000] Linux version 4.17.0+ (kbuild@sof-kbuild01) (gcc version 7.3.0 (Debian 7.3.0-1)) #1 SMP Mon Oct 15 14:03:07 CST 2018 kern :info : [ 0.000000] Command line: BOOT_IMAGE=/pkg/linux/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/vmlinuz-4.17.0+ ip=::::sof-minnow-2::dhcp root=LABEL=LKP-ROOTFS rootflags=subvol=ubuntu-x86_64-2018-02-07-sof user=lkp job=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml ARCH=x86_64 kconfig=x86_64-sof-V4.18-config branch=sof-driver-fuweitax/topic/sof-dev commit=9b33dfacf8f0c9fffc22b1cdd5556faad31ed133 BOOT_IMAGE=/pkg/linux/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/vmlinuz-4.17.0+ audit=0 acpi_rsdp=0x790ff014 max_uptime=3600 RESULT_ROOT=/result/sof_test/defaults/sof-minnow/ubuntu-x86_64-2018-02-07-sof/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/2a48810debefed56ad2ae17061c975410ddaa290/7f47792cbd22886d5fe2acbd229a13a6ea138e66/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net. kern :info : [ 0.000000] KERNEL supported cpus: kern :info : [ 0.000000] Intel GenuineIntel kern :info : [ 0.000000] AMD AuthenticAMD kern :info : [ 0.000000] Centaur CentaurHauls kern :info : [ 0.000000] x86/fpu: x87 FPU will use FXSAVE kern :info : [ 0.000000] e820: BIOS-provided physical RAM map: kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000000000100-0x000000000008efff] usable kern :info : [ 0.000000] BIOS-e820: [mem 0x000000000008f000-0x000000000008ffff] ACPI NVS kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000000090000-0x000000000009dfff] usable kern :info : [ 0.000000] BIOS-e820: [mem 0x000000000009e000-0x00000000000fffff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001fffffff] usable kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000020000000-0x00000000200fffff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000020100000-0x00000000786bffff] usable kern :info : [ 0.000000] BIOS-e820: [mem 0x00000000786c0000-0x0000000078fbffff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000078fc0000-0x00000000790bffff] ACPI NVS kern :info : [ 0.000000] BIOS-e820: [mem 0x00000000790c0000-0x00000000790fffff] ACPI data kern :info : [ 0.000000] BIOS-e820: [mem 0x0000000079100000-0x0000000079ffffff] usable kern :info : [ 0.000000] BIOS-e820: [mem 0x000000007a000000-0x000000007a7fffff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x000000007ae00000-0x000000007fffffff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x00000000e00f8000-0x00000000e00f8fff] reserved kern :info : [ 0.000000] BIOS-e820: [mem 0x00000000fed01000-0x00000000fed01fff] reserved kern :info : [ 0.000000] debug: ignoring loglevel setting. kern :info : [ 0.000000] bootconsole [earlyser0] enabled kern :info : [ 0.000000] NX (Execute Disable) protection: active kern :debug : [ 0.000000] e820: update [mem 0x00100000-0x0010006f] usable ==> usable kern :debug : [ 0.000000] e820: update [mem 0x00100000-0x0010006f] usable ==> usable kern :info : [ 0.000000] extended physical RAM map: kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000000000100-0x000000000008efff] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x000000000008f000-0x000000000008ffff] ACPI NVS kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000000090000-0x000000000009dfff] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x000000000009e000-0x00000000000fffff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000000100000-0x000000000010006f] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000000100070-0x000000001fffffff] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000020000000-0x00000000200fffff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000020100000-0x00000000786bffff] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x00000000786c0000-0x0000000078fbffff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000078fc0000-0x00000000790bffff] ACPI NVS kern :info : [ 0.000000] reserve setup_data: [mem 0x00000000790c0000-0x00000000790fffff] ACPI data kern :info : [ 0.000000] reserve setup_data: [mem 0x0000000079100000-0x0000000079ffffff] usable kern :info : [ 0.000000] reserve setup_data: [mem 0x000000007a000000-0x000000007a7fffff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x000000007ae00000-0x000000007fffffff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x00000000e00f8000-0x00000000e00f8fff] reserved kern :info : [ 0.000000] reserve setup_data: [mem 0x00000000fed01000-0x00000000fed01fff] reserved kern :info : [ 0.000000] efi: EFI v2.60 by EDK II kern :info : [ 0.000000] efi: ACPI=0x790ff000 ACPI 2.0=0x790ff014 SMBIOS=0x78797000 SMBIOS 3.0=0x78795000 ESRT=0x7764ce98 kern :info : [ 0.000000] SMBIOS 3.1.1 present. kern :info : [ 0.000000] DMI: ADI Minnowboard Turbot D0 PLATFORM/MinnowBoard Turbot, BIOS MNW2MAX1.X64.0097.R01.1709211052 09/21/2017 kern :debug : [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved kern :debug : [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable kern :info : [ 0.000000] e820: last_pfn = 0x7a000 max_arch_pfn = 0x400000000 kern :debug : [ 0.000000] MTRR default type: uncachable kern :debug : [ 0.000000] MTRR fixed ranges enabled: kern :debug : [ 0.000000] 00000-9FFFF write-back kern :debug : [ 0.000000] A0000-FFFFF write-protect kern :debug : [ 0.000000] MTRR variable ranges enabled: kern :debug : [ 0.000000] 0 base 0FF800000 mask FFF800000 write-protect kern :debug : [ 0.000000] 1 base 000000000 mask FC0000000 write-back kern :debug : [ 0.000000] 2 base 040000000 mask FE0000000 write-back kern :debug : [ 0.000000] 3 base 060000000 mask FF0000000 write-back kern :debug : [ 0.000000] 4 base 070000000 mask FF8000000 write-back kern :debug : [ 0.000000] 5 base 078000000 mask FFC000000 write-back kern :debug : [ 0.000000] 6 base 07B000000 mask FFF000000 uncachable kern :debug : [ 0.000000] 7 base 07AE00000 mask FFFE00000 uncachable kern :info : [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT kern :warn : [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] kern :warn : [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] kern :warn : [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] kern :err : [ 0.000000] esrt: Unsupported ESRT version -6755262001774592. kern :info : [ 0.000000] Scanning 1 areas for low memory corruption kern :debug : [ 0.000000] Base memory trampoline at [ (ptrval)] 98000 size 24576 kern :debug : [ 0.000000] BRK [0x779f0000, 0x779f0fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f1000, 0x779f1fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f2000, 0x779f2fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f3000, 0x779f3fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f4000, 0x779f4fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f5000, 0x779f5fff] PGTABLE kern :debug : [ 0.000000] BRK [0x779f6000, 0x779f6fff] PGTABLE kern :info : [ 0.000000] Secure boot could not be determined kern :info : [ 0.000000] RAMDISK: [mem 0x6d67a000-0x75ffffff] kern :info : [ 0.000000] ACPI: Early table checksum verification disabled kern :info : [ 0.000000] ACPI: RSDP 0x00000000790FF014 000024 (v02 INTEL ) kern :info : [ 0.000000] ACPI: XSDT 0x00000000790FE0E8 00008C (v01 INTEL EDK2 00000003 01000013) kern :info : [ 0.000000] ACPI: FACP 0x00000000790FD000 00010C (v05 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: DSDT 0x00000000790F1000 007BBE (v02 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: FACS 0x000000007904C000 000040 kern :info : [ 0.000000] ACPI: UEFI 0x000000007904E000 000042 (v01 INTEL EDK2 00000002 01000013) kern :info : [ 0.000000] ACPI: HPET 0x00000000790FC000 000038 (v01 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: LPIT 0x00000000790FB000 000104 (v01 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: APIC 0x00000000790FA000 000084 (v03 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: MCFG 0x00000000790F9000 00003C (v01 INTEL EDK2 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: SSDT 0x00000000790F0000 0004AC (v01 INTEL RHPROXY 00000003 VLV2 0100000D) kern :info : [ 0.000000] ACPI: SSDT 0x00000000790EF000 0007A1 (v01 PmRef CpuPm 00003000 INTL 20160527) kern :info : [ 0.000000] ACPI: SSDT 0x00000000790EE000 000286 (v01 PmRef Cpu0Tst 00003000 INTL 20160527) kern :info : [ 0.000000] ACPI: SSDT 0x00000000790ED000 0001DE (v01 PmRef ApTst 00003000 INTL 20160527) kern :info : [ 0.000000] ACPI: CSRT 0x00000000790EC000 00014C (v00 INTEL EDK2 00000005 INTL 20120624) kern :info : [ 0.000000] ACPI: FPDT 0x00000000790EB000 000044 (v01 INTEL EDK2 00000002 01000013) kern :info : [ 0.000000] ACPI: SSDT 0x00000000790EA000 0002F9 (v02 INTEL 5651Tabl 00001000 INTL 20160831) kern :debug : [ 0.000000] ACPI: Local APIC address 0xfee00000 kern :warn : [ 0.000000] mapped APIC to ffffffffff5fd000 ( fee00000) kern :info : [ 0.000000] No NUMA configuration found kern :info : [ 0.000000] Faking a node at [mem 0x0000000000000000-0x0000000079ffffff] kern :info : [ 0.000000] NODE_DATA(0) allocated [mem 0x79ffa000-0x79ffefff] kern :info : [ 0.000000] Zone ranges: kern :info : [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] kern :info : [ 0.000000] DMA32 [mem 0x0000000001000000-0x0000000079ffffff] kern :info : [ 0.000000] Normal empty kern :info : [ 0.000000] Device empty kern :info : [ 0.000000] Movable zone start for each node kern :info : [ 0.000000] Early memory node ranges kern :info : [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000008efff] kern :info : [ 0.000000] node 0: [mem 0x0000000000090000-0x000000000009dfff] kern :info : [ 0.000000] node 0: [mem 0x0000000000100000-0x000000001fffffff] kern :info : [ 0.000000] node 0: [mem 0x0000000020100000-0x00000000786bffff] kern :info : [ 0.000000] node 0: [mem 0x0000000079100000-0x0000000079ffffff] kern :info : [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000079ffffff] kern :debug : [ 0.000000] On node 0 totalpages: 496732 kern :debug : [ 0.000000] DMA zone: 64 pages used for memmap kern :debug : [ 0.000000] DMA zone: 23 pages reserved kern :debug : [ 0.000000] DMA zone: 3996 pages, LIFO batch:0 kern :debug : [ 0.000000] DMA32 zone: 7744 pages used for memmap kern :debug : [ 0.000000] DMA32 zone: 492736 pages, LIFO batch:31 kern :info : [ 0.000000] Reserved but unavailable: 98 pages kern :info : [ 0.000000] x86/hpet: Will disable the HPET for this platform because it's not reliable kern :info : [ 0.000000] Reserving Intel graphics memory at [mem 0x7b000000-0x7effffff] kern :info : [ 0.000000] ACPI: PM-Timer IO Port: 0x408 kern :debug : [ 0.000000] ACPI: Local APIC address 0xfee00000 kern :info : [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high level lint[0x1]) kern :info : [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x02] high level lint[0x1]) kern :info : [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x03] high level lint[0x1]) kern :info : [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x04] high level lint[0x1]) kern :info : [ 0.000000] IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-86 kern :info : [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 2, APIC INT 02 kern :info : [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) kern :warn : [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 2, APIC INT 09 kern :debug : [ 0.000000] ACPI: IRQ0 used by override. kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 2, APIC INT 01 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 2, APIC INT 03 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 2, APIC INT 04 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 05, APIC ID 2, APIC INT 05 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 2, APIC INT 06 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 2, APIC INT 07 kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 2, APIC INT 08 kern :debug : [ 0.000000] ACPI: IRQ9 used by override. kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0a, APIC ID 2, APIC INT 0a kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0b, APIC ID 2, APIC INT 0b kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 2, APIC INT 0c kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 2, APIC INT 0d kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 2, APIC INT 0e kern :warn : [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 2, APIC INT 0f kern :info : [ 0.000000] Using ACPI (MADT) for SMP configuration information kern :info : [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 kern :info : [ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs kern :warn : [ 0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000) kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x0008f000-0x0008ffff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x0009e000-0x000fffff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x00100000-0x00100fff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x20000000-0x200fffff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x786c0000-0x78fbffff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x78fc0000-0x790bffff] kern :info : [ 0.000000] PM: Registered nosave memory: [mem 0x790c0000-0x790fffff] kern :info : [ 0.000000] e820: [mem 0x80000000-0xe00f7fff] available for PCI devices kern :info : [ 0.000000] Booting paravirtualized kernel on bare hardware kern :info : [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns kern :notice: [ 0.000000] random: get_random_bytes called from start_kernel+0x94/0x4d3 with crng_init=0 kern :info : [ 0.000000] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:4 nr_node_ids:1 kern :info : [ 0.000000] percpu: Embedded 45 pages/cpu @ (ptrval) s146264 r8192 d29864 u524288 kern :debug : [ 0.000000] pcpu-alloc: s146264 r8192 d29864 u524288 alloc=1*2097152 kern :debug : [ 0.000000] pcpu-alloc: [0] 0 1 2 3 kern :info : [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 488901 kern :info : [ 0.000000] Policy zone: DMA32 kern :notice: [ 0.000000] Kernel command line: BOOT_IMAGE=/pkg/linux/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/vmlinuz-4.17.0+ ip=::::sof-minnow-2::dhcp root=LABEL=LKP-ROOTFS rootflags=subvol=ubuntu-x86_64-2018-02-07-sof user=lkp job=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml ARCH=x86_64 kconfig=x86_64-sof-V4.18-config branch=sof-driver-fuweitax/topic/sof-dev commit=9b33dfacf8f0c9fffc22b1cdd5556faad31ed133 BOOT_IMAGE=/pkg/linux/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/vmlinuz-4.17.0+ audit=0 acpi_rsdp=0x790ff014 max_uptime=3600 RESULT_ROOT=/result/sof_test/defaults/sof-minnow/ubuntu-x86_64-2018-02-07-sof/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/2a48810debefed56ad2ae17061c975410ddaa290/7f47792cbd22886d5fe2acbd229a13a6ea138e66/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=1 kern :info : [ 0.000000] audit: disabled (until reboot) kern :info : [ 0.000000] sysrq: sysrq always enabled. kern :debug : [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area kern :debug : [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! kern :info : [ 0.000000] Memory: 1785832K/1986928K available (12300K kernel code, 1554K rwdata, 3992K rodata, 1712K init, 1120K bss, 201096K reserved, 0K cma-reserved) kern :info : [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 kern :info : [ 0.000000] Kernel/User page tables isolation: enabled kern :info : [ 0.000000] ftrace: allocating 38915 entries in 153 pages kern :info : [ 0.000000] Hierarchical RCU implementation. kern :info : [ 0.000000] RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=4. kern :info : [ 0.000000] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). kern :info : [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 kern :info : [ 0.000000] NR_IRQS: 16640, nr_irqs: 1024, preallocated irqs: 16 kern :info : [ 0.000000] Console: colour dummy device 80x25 kern :info : [ 0.000000] console [tty0] enabled kern :info : [ 0.000000] console [ttyS0] enabled kern :info : [ 0.000000] bootconsole [earlyser0] disabled kern :info : [ 0.000000] ACPI: Core revision 20180313 kern :info : [ 0.000000] APIC: Switch to symmetric I/O mode setup kern :warn : [ 0.000000] masked ExtINT on CPU#0 kern :warn : [ 0.000000] ENABLING IO-APIC IRQs kern :debug : [ 0.000000] init IO_APIC IRQs kern :debug : [ 0.000000] apic 2 pin 0 not connected kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-5 -> 0xef -> IRQ 5 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-10 -> 0xef -> IRQ 10 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-11 -> 0xef -> IRQ 11 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] IOAPIC[0]: Set routing entry (2-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1) kern :debug : [ 0.000000] apic 2 pin 16 not connected kern :debug : [ 0.000000] apic 2 pin 17 not connected kern :debug : [ 0.000000] apic 2 pin 18 not connected kern :debug : [ 0.000000] apic 2 pin 19 not connected kern :debug : [ 0.000000] apic 2 pin 20 not connected kern :debug : [ 0.000000] apic 2 pin 21 not connected kern :debug : [ 0.000000] apic 2 pin 22 not connected kern :debug : [ 0.000000] apic 2 pin 23 not connected kern :debug : [ 0.000000] apic 2 pin 24 not connected kern :debug : [ 0.000000] apic 2 pin 25 not connected kern :debug : [ 0.000000] apic 2 pin 26 not connected kern :debug : [ 0.000000] apic 2 pin 27 not connected kern :debug : [ 0.000000] apic 2 pin 28 not connected kern :debug : [ 0.000000] apic 2 pin 29 not connected kern :debug : [ 0.000000] apic 2 pin 30 not connected kern :debug : [ 0.000000] apic 2 pin 31 not connected kern :debug : [ 0.000000] apic 2 pin 32 not connected kern :debug : [ 0.000000] apic 2 pin 33 not connected kern :debug : [ 0.000000] apic 2 pin 34 not connected kern :debug : [ 0.000000] apic 2 pin 35 not connected kern :debug : [ 0.000000] apic 2 pin 36 not connected kern :debug : [ 0.000000] apic 2 pin 37 not connected kern :debug : [ 0.000000] apic 2 pin 38 not connected kern :debug : [ 0.000000] apic 2 pin 39 not connected kern :debug : [ 0.000000] apic 2 pin 40 not connected kern :debug : [ 0.000000] apic 2 pin 41 not connected kern :debug : [ 0.000000] apic 2 pin 42 not connected kern :debug : [ 0.000000] apic 2 pin 43 not connected kern :debug : [ 0.000000] apic 2 pin 44 not connected kern :debug : [ 0.000000] apic 2 pin 45 not connected kern :debug : [ 0.000000] apic 2 pin 46 not connected kern :debug : [ 0.000000] apic 2 pin 47 not connected kern :debug : [ 0.000000] apic 2 pin 48 not connected kern :debug : [ 0.000000] apic 2 pin 49 not connected kern :debug : [ 0.000000] apic 2 pin 50 not connected kern :debug : [ 0.000000] apic 2 pin 51 not connected kern :debug : [ 0.000000] apic 2 pin 52 not connected kern :debug : [ 0.000000] apic 2 pin 53 not connected kern :debug : [ 0.000000] apic 2 pin 54 not connected kern :debug : [ 0.000000] apic 2 pin 55 not connected kern :debug : [ 0.000000] apic 2 pin 56 not connected kern :debug : [ 0.000000] apic 2 pin 57 not connected kern :debug : [ 0.000000] apic 2 pin 58 not connected kern :debug : [ 0.000000] apic 2 pin 59 not connected kern :debug : [ 0.000000] apic 2 pin 60 not connected kern :debug : [ 0.000000] apic 2 pin 61 not connected kern :debug : [ 0.000000] apic 2 pin 62 not connected kern :debug : [ 0.000000] apic 2 pin 63 not connected kern :debug : [ 0.000000] apic 2 pin 64 not connected kern :debug : [ 0.000000] apic 2 pin 65 not connected kern :debug : [ 0.000000] apic 2 pin 66 not connected kern :debug : [ 0.000000] apic 2 pin 67 not connected kern :debug : [ 0.000000] apic 2 pin 68 not connected kern :debug : [ 0.000000] apic 2 pin 69 not connected kern :debug : [ 0.000000] apic 2 pin 70 not connected kern :debug : [ 0.000000] apic 2 pin 71 not connected kern :debug : [ 0.000000] apic 2 pin 72 not connected kern :debug : [ 0.000000] apic 2 pin 73 not connected kern :debug : [ 0.000000] apic 2 pin 74 not connected kern :debug : [ 0.000000] apic 2 pin 75 not connected kern :debug : [ 0.000000] apic 2 pin 76 not connected kern :debug : [ 0.000000] apic 2 pin 77 not connected kern :debug : [ 0.000000] apic 2 pin 78 not connected kern :debug : [ 0.000000] apic 2 pin 79 not connected kern :debug : [ 0.000000] apic 2 pin 80 not connected kern :debug : [ 0.000000] apic 2 pin 81 not connected kern :debug : [ 0.000000] apic 2 pin 82 not connected kern :debug : [ 0.000000] apic 2 pin 83 not connected kern :debug : [ 0.000000] apic 2 pin 84 not connected kern :debug : [ 0.000000] apic 2 pin 85 not connected kern :debug : [ 0.000000] apic 2 pin 86 not connected kern :info : [ 0.000000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 kern :info : [ 0.020000] tsc: Detected 1915.900 MHz processor kern :info : [ 0.024000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x373bb0d4809, max_idle_ns: 881590714052 ns kern :info : [ 0.028022] Calibrating delay loop (skipped), value calculated using timer frequency.. 3831.80 BogoMIPS (lpj=7663600) kern :info : [ 0.032017] pid_max: default: 32768 minimum: 301 kern :info : [ 0.036888] Security Framework initialized kern :info : [ 0.040019] Yama: becoming mindful. kern :info : [ 0.044106] AppArmor: AppArmor initialized kern :info : [ 0.049781] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) kern :info : [ 0.052867] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) kern :info : [ 0.056122] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) kern :info : [ 0.060060] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) kern :info : [ 0.065158] CPU: Physical Processor ID: 0 kern :info : [ 0.068017] CPU: Processor Core ID: 0 kern :info : [ 0.072050] mce: CPU supports 6 MCE banks kern :info : [ 0.076034] process: using mwait in idle threads kern :info : [ 0.080024] Last level iTLB entries: 4KB 48, 2MB 0, 4MB 0 kern :info : [ 0.084016] Last level dTLB entries: 4KB 128, 2MB 16, 4MB 16, 1GB 0 kern :info : [ 0.088043] Spectre V2 : Mitigation: Full generic retpoline kern :info : [ 0.092836] Freeing SMP alternatives memory: 36K kern :debug : [ 0.105941] TSC deadline timer enabled kern :info : [ 0.108000] smpboot: CPU0: Intel(R) Atom(TM) CPU E3845 @ 1.91GHz (family: 0x6, model: 0x37, stepping: 0x9) kern :info : [ 0.108763] Performance Events: PEBS fmt2+, 8-deep LBR, Silvermont events, 8-deep LBR, full-width counters, Intel PMU driver. kern :info : [ 0.112053] ... version: 3 kern :info : [ 0.116017] ... bit width: 40 kern :info : [ 0.120014] ... generic registers: 2 kern :info : [ 0.124015] ... value mask: 000000ffffffffff kern :info : [ 0.128015] ... max period: 0000007fffffffff kern :info : [ 0.132014] ... fixed-purpose events: 3 kern :info : [ 0.136023] ... event mask: 0000000700000003 kern :info : [ 0.140256] Hierarchical SRCU implementation. kern :info : [ 0.149083] NMI watchdog: Enabled. Permanently consumes one hw-PMU counter. kern :info : [ 0.152120] smp: Bringing up secondary CPUs ... kern :info : [ 0.157030] x86: Booting SMP configuration: kern :info : [ 0.160038] .... node #0, CPUs: #1 kern :warn : [ 0.004000] masked ExtINT on CPU#1 kern :warn : [ 0.168870] #2 kern :warn : [ 0.004000] masked ExtINT on CPU#2 kern :warn : [ 0.176732] #3 kern :warn : [ 0.004000] masked ExtINT on CPU#3 kern :info : [ 0.182674] smp: Brought up 1 node, 4 CPUs kern :info : [ 0.184021] smpboot: Max logical packages: 1 kern :info : [ 0.188021] smpboot: Total of 4 processors activated (15327.20 BogoMIPS) kern :info : [ 0.194171] devtmpfs: initialized kern :info : [ 0.196000] x86/mm: Memory block size: 128MB kern :info : [ 0.203093] evm: security.selinux kern :info : [ 0.208020] evm: security.SMACK64 kern :info : [ 0.211737] evm: security.SMACK64EXEC kern :info : [ 0.216016] evm: security.SMACK64TRANSMUTE kern :info : [ 0.220014] evm: security.SMACK64MMAP kern :info : [ 0.224014] evm: security.apparmor kern :info : [ 0.227826] evm: security.ima kern :info : [ 0.232014] evm: security.capability kern :info : [ 0.237263] PM: Registering ACPI NVS region [mem 0x0008f000-0x0008ffff] (4096 bytes) kern :info : [ 0.248034] PM: Registering ACPI NVS region [mem 0x78fc0000-0x790bffff] (1048576 bytes) kern :info : [ 0.256452] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns kern :info : [ 0.268080] futex hash table entries: 1024 (order: 4, 65536 bytes) kern :info : [ 0.272373] pinctrl core: initialized pinctrl subsystem kern :info : [ 0.280611] RTC time: 13:56:39, date: 09/22/17 kern :info : [ 0.284556] NET: Registered protocol family 16 kern :info : [ 0.294510] cpuidle: using governor ladder kern :info : [ 0.296095] cpuidle: using governor menu kern :info : [ 0.301221] ACPI: bus type PCI registered kern :info : [ 0.304021] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 kern :info : [ 0.312428] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000) kern :info : [ 0.324083] PCI: not using MMCONFIG kern :info : [ 0.328000] PCI: Using configuration type 1 for base access kern :info : [ 0.344320] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages kern :info : [ 0.356902] ACPI: Added _OSI(Module Device) kern :info : [ 0.360033] ACPI: Added _OSI(Processor Device) kern :info : [ 0.364022] ACPI: Added _OSI(3.0 _SCP Extensions) kern :info : [ 0.368017] ACPI: Added _OSI(Processor Aggregator Device) kern :info : [ 0.372020] ACPI: Added _OSI(Linux-Dell-Video) kern :info : [ 0.411702] ACPI: 6 ACPI AML tables successfully acquired and loaded kern :info : [ 0.431657] ACPI: Dynamic OEM Table Load: kern :info : [ 0.432047] ACPI: SSDT 0xFFFF96D6AB296800 0003B3 (v01 PmRef Cpu0Ist 00003000 INTL 20160527) kern :info : [ 0.437993] ACPI: Dynamic OEM Table Load: kern :info : [ 0.440042] ACPI: SSDT 0xFFFF96D6AB296C00 000258 (v01 PmRef Cpu0Cst 00003001 INTL 20160527) kern :info : [ 0.446907] ACPI: Dynamic OEM Table Load: kern :info : [ 0.448043] ACPI: SSDT 0xFFFF96D6AB260400 0001E0 (v01 PmRef ApIst 00003000 INTL 20160527) kern :info : [ 0.453418] ACPI: Dynamic OEM Table Load: kern :info : [ 0.456040] ACPI: SSDT 0xFFFF96D6AB3B3300 0000C9 (v01 PmRef ApCst 00003000 INTL 20160527) kern :info : [ 0.467764] ACPI: Interpreter enabled kern :info : [ 0.468160] ACPI: (supports S0 S1 S3 S4 S5) kern :info : [ 0.472020] ACPI: Using IOAPIC for interrupt routing kern :info : [ 0.476242] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000) kern :info : [ 0.482512] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in ACPI motherboard resources kern :info : [ 0.484074] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug kern :info : [ 0.489994] ACPI: Enabled 4 GPEs in block 00 to 3F kern :info : [ 0.522878] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.529728] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.537290] ACPI: Power Resource [USBC] (on) kern :info : [ 0.551826] (null): Device [PWM1] is in always present list kern :info : [ 0.568889] ACPI: Power Resource [CLK0] (on) kern :info : [ 0.572329] ACPI: Power Resource [CLK1] (on) kern :info : [ 0.585069] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.592099] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) kern :info : [ 0.600044] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI] kern :info : [ 0.609321] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug] kern :info : [ 0.617344] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] kern :info : [ 0.628090] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge kern :info : [ 0.642208] PCI host bridge to bus 0000:00 kern :info : [ 0.644031] pci_bus 0000:00: root bus resource [io 0x0070-0x0077] kern :info : [ 0.652026] pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] kern :info : [ 0.660024] pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] kern :info : [ 0.668024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] kern :info : [ 0.676024] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] kern :info : [ 0.684023] pci_bus 0000:00: root bus resource [mem 0x000c0000-0x000dffff window] kern :info : [ 0.692023] pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000fffff window] kern :info : [ 0.700024] pci_bus 0000:00: root bus resource [mem 0x91000000-0x913fffff window] kern :info : [ 0.708024] pci_bus 0000:00: root bus resource [mem 0x80000000-0x909ffffe window] kern :info : [ 0.716024] pci_bus 0000:00: root bus resource [bus 00-ff] kern :debug : [ 0.724052] pci 0000:00:00.0: [8086:0f00] type 00 class 0x060000 kern :debug : [ 0.732604] pci 0000:00:02.0: [8086:0f31] type 00 class 0x030000 kern :debug : [ 0.736069] pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x903fffff] kern :debug : [ 0.744057] pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff pref] kern :debug : [ 0.752044] pci 0000:00:02.0: reg 0x20: [io 0x2050-0x2057] kern :debug : [ 0.760625] pci 0000:00:14.0: [8086:0f35] type 00 class 0x0c0330 kern :debug : [ 0.764071] pci 0000:00:14.0: reg 0x10: [mem 0x90900000-0x9090ffff 64bit] kern :debug : [ 0.772158] pci 0000:00:14.0: PME# supported from D3hot D3cold kern :debug : [ 0.780531] pci 0000:00:1a.0: [8086:0f18] type 00 class 0x108000 kern :debug : [ 0.788069] pci 0000:00:1a.0: reg 0x10: [mem 0x90800000-0x908fffff] kern :debug : [ 0.796040] pci 0000:00:1a.0: reg 0x14: [mem 0x90700000-0x907fffff] kern :debug : [ 0.800176] pci 0000:00:1a.0: PME# supported from D0 D3hot kern :debug : [ 0.808528] pci 0000:00:1b.0: [8086:0f04] type 00 class 0x040300 kern :debug : [ 0.816075] pci 0000:00:1b.0: reg 0x10: [mem 0x90910000-0x90913fff 64bit] kern :debug : [ 0.824169] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold kern :debug : [ 0.828514] pci 0000:00:1c.0: [8086:0f48] type 01 class 0x060400 kern :debug : [ 0.836184] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold kern :debug : [ 0.844559] pci 0000:00:1c.1: [8086:0f4a] type 01 class 0x060400 kern :debug : [ 0.852183] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold kern :debug : [ 0.860546] pci 0000:00:1c.2: [8086:0f4c] type 01 class 0x060400 kern :debug : [ 0.864181] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold kern :debug : [ 0.872565] pci 0000:00:1c.3: [8086:0f4e] type 01 class 0x060400 kern :debug : [ 0.880182] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold kern :debug : [ 0.888557] pci 0000:00:1f.0: [8086:0f1c] type 00 class 0x060100 kern :debug : [ 0.896649] pci 0000:00:1f.3: [8086:0f12] type 00 class 0x0c0500 kern :debug : [ 0.900088] pci 0000:00:1f.3: reg 0x10: [mem 0x9091c000-0x9091c01f] kern :debug : [ 0.908114] pci 0000:00:1f.3: reg 0x20: [io 0x2000-0x201f] kern :info : [ 0.916867] pci 0000:00:1c.0: PCI bridge to [bus 01] kern :debug : [ 0.920031] pci 0000:00:1c.0: bridge window [io 0x3000-0x3fff] kern :info : [ 0.928276] pci 0000:00:1c.1: PCI bridge to [bus 02] kern :debug : [ 0.936032] pci 0000:00:1c.1: bridge window [io 0x4000-0x4fff] kern :debug : [ 0.940350] pci 0000:03:00.0: [8086:1533] type 00 class 0x020000 kern :debug : [ 0.948103] pci 0000:03:00.0: reg 0x10: [mem 0x90600000-0x9067ffff] kern :debug : [ 0.956071] pci 0000:03:00.0: reg 0x18: [io 0x1000-0x101f] kern :debug : [ 0.960052] pci 0000:03:00.0: reg 0x1c: [mem 0x90680000-0x90683fff] kern :debug : [ 0.968263] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold kern :info : [ 0.976444] pci 0000:00:1c.2: PCI bridge to [bus 03] kern :debug : [ 0.980031] pci 0000:00:1c.2: bridge window [io 0x1000-0x1fff] kern :debug : [ 0.988027] pci 0000:00:1c.2: bridge window [mem 0x90600000-0x906fffff] kern :debug : [ 0.996037] pci 0000:00:1c.2: bridge window [mem 0x90400000-0x905fffff 64bit pref] kern :info : [ 1.004274] pci 0000:00:1c.3: PCI bridge to [bus 04] kern :debug : [ 1.012031] pci 0000:00:1c.3: bridge window [io 0x5000-0x5fff] kern :debug : [ 1.016027] pci 0000:00:1c.3: bridge window [mem 0x91000000-0x911fffff] kern :debug : [ 1.024030] pci 0000:00:1c.3: bridge window [mem 0x91200000-0x913fffff 64bit pref] kern :info : [ 1.034516] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.044517] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.056522] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.064536] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.072508] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.084506] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.092505] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.104502] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :debug : [ 1.113672] IOAPIC[0]: Set routing entry (2-49 -> 0xef -> IRQ 49 Mode:1 Active:1 Dest:1) kern :debug : [ 1.124997] IOAPIC[0]: Set routing entry (2-48 -> 0xef -> IRQ 48 Mode:1 Active:1 Dest:1) kern :debug : [ 1.132744] IOAPIC[0]: Set routing entry (2-50 -> 0xef -> IRQ 50 Mode:1 Active:1 Dest:1) kern :debug : [ 1.146050] IOAPIC[0]: Set routing entry (2-44 -> 0xef -> IRQ 44 Mode:1 Active:1 Dest:1) kern :debug : [ 1.156832] IOAPIC[0]: Set routing entry (2-46 -> 0xef -> IRQ 46 Mode:1 Active:1 Dest:1) kern :debug : [ 1.164791] IOAPIC[0]: Set routing entry (2-47 -> 0xef -> IRQ 47 Mode:1 Active:1 Dest:1) kern :debug : [ 1.177003] IOAPIC[0]: Set routing entry (2-42 -> 0xef -> IRQ 42 Mode:1 Active:1 Dest:1) kern :debug : [ 1.184980] IOAPIC[0]: Set routing entry (2-43 -> 0xef -> IRQ 43 Mode:1 Active:1 Dest:1) kern :debug : [ 1.198775] IOAPIC[0]: Set routing entry (2-39 -> 0xef -> IRQ 39 Mode:1 Active:1 Dest:1) kern :debug : [ 1.209201] IOAPIC[0]: Set routing entry (2-40 -> 0xef -> IRQ 40 Mode:1 Active:1 Dest:1) kern :debug : [ 1.217190] IOAPIC[0]: Set routing entry (2-41 -> 0xef -> IRQ 41 Mode:1 Active:1 Dest:1) kern :debug : [ 1.230245] IOAPIC[0]: Set routing entry (2-37 -> 0xef -> IRQ 37 Mode:1 Active:1 Dest:1) kern :debug : [ 1.241769] IOAPIC[0]: Set routing entry (2-38 -> 0xef -> IRQ 38 Mode:1 Active:1 Dest:1) kern :debug : [ 1.249246] IOAPIC[0]: Set routing entry (2-24 -> 0xef -> IRQ 24 Mode:1 Active:1 Dest:1) kern :debug : [ 1.260116] IOAPIC[0]: Set routing entry (2-25 -> 0xef -> IRQ 25 Mode:1 Active:1 Dest:1) kern :debug : [ 1.268099] IOAPIC[0]: Set routing entry (2-26 -> 0xef -> IRQ 26 Mode:1 Active:1 Dest:1) kern :debug : [ 1.276088] IOAPIC[0]: Set routing entry (2-27 -> 0xef -> IRQ 27 Mode:1 Active:1 Dest:1) kern :debug : [ 1.288088] IOAPIC[0]: Set routing entry (2-28 -> 0xef -> IRQ 28 Mode:1 Active:1 Dest:1) kern :debug : [ 1.296098] IOAPIC[0]: Set routing entry (2-29 -> 0xef -> IRQ 29 Mode:1 Active:1 Dest:1) kern :info : [ 1.344917] dw_dmac INTL9C60:00: DesignWare DMA Controller, 8 channels kern :info : [ 1.396883] dw_dmac INTL9C60:01: DesignWare DMA Controller, 8 channels kern :info : [ 1.408051] pci 0000:00:02.0: vgaarb: setting as boot VGA device kern :info : [ 1.412000] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none kern :info : [ 1.424042] pci 0000:00:02.0: vgaarb: bridge control possible kern :info : [ 1.428016] vgaarb: loaded kern :notice: [ 1.432368] SCSI subsystem initialized kern :debug : [ 1.440093] libata version 3.00 loaded. kern :info : [ 1.444180] ACPI: bus type USB registered kern :info : [ 1.448128] usbcore: registered new interface driver usbfs kern :info : [ 1.452081] usbcore: registered new interface driver hub kern :info : [ 1.460145] usbcore: registered new device driver usb kern :info : [ 1.541519] pps_core: LinuxPPS API ver. 1 registered kern :info : [ 1.548021] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti kern :info : [ 1.560055] PTP clock support registered kern :info : [ 1.564158] EDAC MC: Ver: 3.0.0 kern :info : [ 1.568249] Registered efivars operations kern :info : [ 1.584832] PCI: Using ACPI for IRQ routing kern :debug : [ 1.590695] PCI: pci_cache_line_size set to 64 bytes kern :debug : [ 1.596140] e820: reserve RAM buffer [mem 0x0008f000-0x0008ffff] kern :debug : [ 1.604022] e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] kern :debug : [ 1.612020] e820: reserve RAM buffer [mem 0x786c0000-0x7bffffff] kern :debug : [ 1.616020] e820: reserve RAM buffer [mem 0x7a000000-0x7bffffff] kern :info : [ 1.624639] NetLabel: Initializing kern :info : [ 1.628020] NetLabel: domain hash size = 128 kern :info : [ 1.632014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO kern :info : [ 1.640108] NetLabel: unlabeled traffic allowed by default kern :info : [ 1.649406] clocksource: Switched to clocksource tsc-early kern :notice: [ 1.740745] VFS: Disk quotas dquot_6.6.0 kern :info : [ 1.745279] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) kern :info : [ 1.753656] AppArmor: AppArmor Filesystem Enabled kern :info : [ 1.759160] pnp: PnP ACPI init kern :debug : [ 1.763076] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) kern :info : [ 1.770819] system 00:01: [io 0x0680-0x069f] has been reserved kern :info : [ 1.777511] system 00:01: [io 0x0400-0x047f] has been reserved kern :info : [ 1.784180] system 00:01: [io 0x0500-0x05fe] has been reserved kern :debug : [ 1.790869] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) kern :debug : [ 1.799115] pnp 00:02: Plug and Play ACPI device, IDs PNP0501 (active) kern :info : [ 1.808097] system 00:03: [mem 0xe0000000-0xefffffff] could not be reserved kern :info : [ 1.815938] system 00:03: [mem 0xfed01000-0xfed01fff] has been reserved kern :info : [ 1.823381] system 00:03: [mem 0xfed03000-0xfed03fff] has been reserved kern :info : [ 1.830854] system 00:03: [mem 0xfed04000-0xfed04fff] has been reserved kern :info : [ 1.838300] system 00:03: [mem 0xfed0c000-0xfed0ffff] could not be reserved kern :info : [ 1.846144] system 00:03: [mem 0xfed08000-0xfed08fff] has been reserved kern :info : [ 1.853588] system 00:03: [mem 0xfed1c000-0xfed1cfff] has been reserved kern :info : [ 1.861028] system 00:03: [mem 0xfee00000-0xfeefffff] has been reserved kern :info : [ 1.868470] system 00:03: [mem 0xfef00000-0xfeffffff] has been reserved kern :debug : [ 1.875933] system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active) kern :info : [ 1.889424] pnp: PnP ACPI: found 4 devices kern :info : [ 1.911124] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns kern :debug : [ 1.921150] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000 kern :debug : [ 1.934049] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff] to [bus 01] add_size 200000 add_align 100000 kern :debug : [ 1.945885] pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 kern :debug : [ 1.958778] pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff] to [bus 02] add_size 200000 add_align 100000 kern :info : [ 1.970656] pci 0000:00:1c.0: BAR 14: no space for [mem size 0x00200000] kern :info : [ 1.978194] pci 0000:00:1c.0: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 1.986144] pci 0000:00:1c.0: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 1.994751] pci 0000:00:1c.0: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.003757] pci 0000:00:1c.1: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.011284] pci 0000:00:1c.1: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.019233] pci 0000:00:1c.1: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.027839] pci 0000:00:1c.1: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.036862] pci 0000:00:1c.1: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.044401] pci 0000:00:1c.1: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.052350] pci 0000:00:1c.1: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.060956] pci 0000:00:1c.1: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.069961] pci 0000:00:1c.0: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.077497] pci 0000:00:1c.0: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.085443] pci 0000:00:1c.0: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.094050] pci 0000:00:1c.0: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.103048] pci 0000:00:1c.0: PCI bridge to [bus 01] kern :info : [ 2.108640] pci 0000:00:1c.0: bridge window [io 0x3000-0x3fff] kern :info : [ 2.115511] pci 0000:00:1c.1: PCI bridge to [bus 02] kern :info : [ 2.121102] pci 0000:00:1c.1: bridge window [io 0x4000-0x4fff] kern :info : [ 2.127973] pci 0000:00:1c.2: PCI bridge to [bus 03] kern :info : [ 2.133563] pci 0000:00:1c.2: bridge window [io 0x1000-0x1fff] kern :info : [ 2.140422] pci 0000:00:1c.2: bridge window [mem 0x90600000-0x906fffff] kern :info : [ 2.148055] pci 0000:00:1c.2: bridge window [mem 0x90400000-0x905fffff 64bit pref] kern :info : [ 2.156762] pci 0000:00:1c.3: PCI bridge to [bus 04] kern :info : [ 2.162365] pci 0000:00:1c.3: bridge window [io 0x5000-0x5fff] kern :info : [ 2.169235] pci 0000:00:1c.3: bridge window [mem 0x91000000-0x911fffff] kern :info : [ 2.176872] pci 0000:00:1c.3: bridge window [mem 0x91200000-0x913fffff 64bit pref] kern :debug : [ 2.185583] pci_bus 0000:00: resource 4 [io 0x0070-0x0077] kern :debug : [ 2.191853] pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] kern :debug : [ 2.198803] pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] kern :debug : [ 2.205753] pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] kern :debug : [ 2.212702] pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window] kern :debug : [ 2.220429] pci_bus 0000:00: resource 9 [mem 0x000c0000-0x000dffff window] kern :debug : [ 2.228155] pci_bus 0000:00: resource 10 [mem 0x000e0000-0x000fffff window] kern :debug : [ 2.235979] pci_bus 0000:00: resource 11 [mem 0x91000000-0x913fffff window] kern :debug : [ 2.243804] pci_bus 0000:00: resource 12 [mem 0x80000000-0x909ffffe window] kern :debug : [ 2.251627] pci_bus 0000:01: resource 0 [io 0x3000-0x3fff] kern :debug : [ 2.257895] pci_bus 0000:02: resource 0 [io 0x4000-0x4fff] kern :debug : [ 2.264164] pci_bus 0000:03: resource 0 [io 0x1000-0x1fff] kern :debug : [ 2.270431] pci_bus 0000:03: resource 1 [mem 0x90600000-0x906fffff] kern :debug : [ 2.277478] pci_bus 0000:03: resource 2 [mem 0x90400000-0x905fffff 64bit pref] kern :debug : [ 2.285595] pci_bus 0000:04: resource 0 [io 0x5000-0x5fff] kern :debug : [ 2.291862] pci_bus 0000:04: resource 1 [mem 0x91000000-0x911fffff] kern :debug : [ 2.298918] pci_bus 0000:04: resource 2 [mem 0x91200000-0x913fffff 64bit pref] kern :info : [ 2.307501] NET: Registered protocol family 2 kern :info : [ 2.313243] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes) kern :info : [ 2.322155] TCP established hash table entries: 16384 (order: 5, 131072 bytes) kern :info : [ 2.330532] TCP bind hash table entries: 16384 (order: 6, 262144 bytes) kern :info : [ 2.338270] TCP: Hash tables configured (established 16384 bind 16384) kern :info : [ 2.345791] UDP hash table entries: 1024 (order: 3, 32768 bytes) kern :info : [ 2.352629] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) kern :info : [ 2.360157] NET: Registered protocol family 1 kern :info : [ 2.365140] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] kern :debug : [ 2.375073] IOAPIC[0]: Set routing entry (2-20 -> 0xef -> IRQ 20 Mode:1 Active:1 Dest:1) kern :debug : [ 2.384774] PCI: CLS 128 bytes, default 64 kern :info : [ 2.389673] Trying to unpack rootfs image as initramfs... kern :info : [ 19.658212] Freeing initrd memory: 140824K kern :info : [ 19.664386] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x373bb0d4809, max_idle_ns: 881590714052 ns kern :info : [ 19.675707] clocksource: Switched to clocksource tsc kern :info : [ 19.681566] Scanning for low memory corruption every 60 seconds kern :notice: [ 19.692556] Initialise system trusted keyrings kern :info : [ 19.697823] workingset: timestamp_bits=40 max_order=19 bucket_order=0 kern :info : [ 19.714920] zbud: loaded kern :info : [ 19.722178] fuse init (API version 7.26) kern :info : [ 19.727111] pstore: using deflate compression kern :notice: [ 19.735619] Key type asymmetric registered kern :notice: [ 19.740256] Asymmetric key parser 'x509' registered kern :info : [ 19.745969] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) kern :info : [ 19.754489] io scheduler noop registered kern :info : [ 19.758926] io scheduler deadline registered (default) kern :info : [ 19.765027] io scheduler cfq registered kern :info : [ 19.769361] io scheduler mq-deadline registered (default) kern :info : [ 19.775436] io scheduler kyber registered kern :debug : [ 19.781078] IOAPIC[0]: Set routing entry (2-16 -> 0xef -> IRQ 16 Mode:1 Active:1 Dest:1) kern :debug : [ 19.791050] IOAPIC[0]: Set routing entry (2-17 -> 0xef -> IRQ 17 Mode:1 Active:1 Dest:1) kern :debug : [ 19.800961] IOAPIC[0]: Set routing entry (2-18 -> 0xef -> IRQ 18 Mode:1 Active:1 Dest:1) kern :debug : [ 19.810909] IOAPIC[0]: Set routing entry (2-19 -> 0xef -> IRQ 19 Mode:1 Active:1 Dest:1) kern :info : [ 19.820556] pcieport 0000:00:1c.0: Signaling PME with IRQ 87 kern :info : [ 19.827060] pcieport 0000:00:1c.1: Signaling PME with IRQ 88 kern :info : [ 19.833569] pcieport 0000:00:1c.2: Signaling PME with IRQ 89 kern :info : [ 19.840080] pcieport 0000:00:1c.3: Signaling PME with IRQ 90 kern :debug : [ 19.846739] intel_idle: MWAIT substates: 0x3000020 kern :debug : [ 19.852143] intel_idle: v0.4.1 model 0x37 kern :debug : [ 19.857451] intel_idle: lapic_timer_reliable_states 0xffffffff kern :info : [ 19.864547] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 kern :info : [ 19.874015] ACPI: Power Button [PWRB] kern :info : [ 19.878428] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 kern :info : [ 19.887869] ACPI: Sleep Button [SLPB] kern :info : [ 19.892307] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 kern :info : [ 19.900695] ACPI: Power Button [PWRF] kern :info : [ 19.919612] thermal LNXTHERM:00: registered as thermal_zone0 kern :info : [ 19.926008] ACPI: Thermal Zone [TZ01] (31 C) kern :info : [ 19.931889] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled kern :info : [ 19.959391] 00:02: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A kern :warn : [ 19.981533] hpet: number irqs doesn't agree with number of timers kern :info : [ 19.988791] Linux agpgart interface v0.103 kern :info : [ 20.016366] brd: module loaded kern :info : [ 20.031203] loop: module loaded kern :info : [ 20.037859] libphy: Fixed MDIO Bus: probed kern :info : [ 20.042513] tun: Universal TUN/TAP device driver, 1.6 kern :info : [ 20.048945] PPP generic driver version 2.4.2 kern :info : [ 20.054537] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver kern :info : [ 20.061918] ehci-pci: EHCI PCI platform driver kern :info : [ 20.066998] ehci-platform: EHCI generic platform driver kern :info : [ 20.072965] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver kern :info : [ 20.079937] ohci-pci: OHCI PCI platform driver kern :info : [ 20.085020] ohci-platform: OHCI generic platform driver kern :info : [ 20.090965] uhci_hcd: USB Universal Host Controller Interface driver kern :debug : [ 20.098807] IOAPIC[0]: Set routing entry (2-20 -> 0xef -> IRQ 20 Mode:1 Active:1 Dest:1) kern :info : [ 20.108003] xhci_hcd 0000:00:14.0: xHCI Host Controller kern :info : [ 20.114157] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 kern :info : [ 20.123644] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x00009810 kern :debug : [ 20.133147] xhci_hcd 0000:00:14.0: cache line size of 128 is not supported kern :info : [ 20.141516] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.17 kern :info : [ 20.150838] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 kern :info : [ 20.158968] usb usb1: Product: xHCI Host Controller kern :info : [ 20.164473] usb usb1: Manufacturer: Linux 4.17.0+ xhci-hcd kern :info : [ 20.170652] usb usb1: SerialNumber: 0000:00:14.0 kern :info : [ 20.176906] hub 1-0:1.0: USB hub found kern :info : [ 20.181196] hub 1-0:1.0: 6 ports detected kern :info : [ 20.188464] xhci_hcd 0000:00:14.0: xHCI Host Controller kern :info : [ 20.194380] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 kern :info : [ 20.202720] xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed kern :info : [ 20.210139] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.17 kern :info : [ 20.219457] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 kern :info : [ 20.227588] usb usb2: Product: xHCI Host Controller kern :info : [ 20.233086] usb usb2: Manufacturer: Linux 4.17.0+ xhci-hcd kern :info : [ 20.239264] usb usb2: SerialNumber: 0000:00:14.0 kern :info : [ 20.245467] hub 2-0:1.0: USB hub found kern :info : [ 20.249760] hub 2-0:1.0: 1 port detected kern :info : [ 20.255197] i8042: PNP: No PS/2 controller found. kern :info : [ 20.260504] i8042: Probing ports directly. kern :info : [ 21.300927] i8042: No controller found kern :info : [ 21.306032] mousedev: PS/2 mouse device common for all mice kern :info : [ 21.313838] rtc_cmos 00:00: RTC can wake from S4 kern :info : [ 21.319562] rtc_cmos 00:00: registered as rtc0 kern :info : [ 21.324694] rtc_cmos 00:00: alarms up to one month, y3k, 242 bytes nvram kern :info : [ 21.332297] i2c /dev entries driver kern :info : [ 21.337126] device-mapper: uevent: version 1.0.3 kern :info : [ 21.342880] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com kern :info : [ 21.352393] intel_pstate: Intel P-state driver initializing kern :info : [ 21.360482] ledtrig-cpu: registered to indicate activity on CPUs kern :info : [ 21.367207] EFI Variables Facility v0.08 2004-May-17 kern :info : [ 21.390569] NET: Registered protocol family 10 kern :info : [ 21.396884] Segment Routing with IPv6 kern :info : [ 21.401012] NET: Registered protocol family 17 kern :notice: [ 21.406004] Key type dns_resolver registered kern :info : [ 21.413297] microcode: sig=0x30679, pf=0x1, revision=0x906 kern :info : [ 21.420373] microcode: Microcode Update Driver: v2.2. kern :info : [ 21.420471] ... APIC ID: 00000000 (0) kern :info : [ 21.424467] ... APIC VERSION: 00050014 kern :warn : [ 21.424467] 0000000000000000000000000000000000000000000000000000000000000000 kern :warn : [ 21.424467] 0000000002000004000000000002000000020002000000000000000000000000 kern :warn : [ 21.444441] 0000000000000000000000000000000000000000000000000000000000001000 kern :debug : [ 21.458527] number of MP IRQ sources: 15. kern :debug : [ 21.463011] number of IO-APIC #2 registers: 87. kern :info : [ 21.468079] testing the IO APIC....................... kern :debug : [ 21.473822] IO APIC #2...... kern :debug : [ 21.477042] .... register #00: 01000000 kern :debug : [ 21.481330] ....... : physical APIC id: 01 kern :debug : [ 21.486201] ....... : Delivery Type: 0 kern :debug : [ 21.490685] ....... : LTS : 0 kern :debug : [ 21.495168] .... register #01: 00560020 kern :debug : [ 21.499456] ....... : max redirection entries: 56 kern :debug : [ 21.505107] ....... : PRQ implemented: 0 kern :debug : [ 21.509873] ....... : IO APIC version: 20 kern :debug : [ 21.514744] .... IRQ redirection table: kern :debug : [ 21.519034] IOAPIC 0: kern :debug : [ 21.521583] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.530349] pin01, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.539115] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 21.547879] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.556644] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.565407] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.574171] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.582935] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.591698] pin08, enabled , level, high, V(24), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 21.600462] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(02), M(0) kern :debug : [ 21.609227] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.617992] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.626758] pin0c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.635523] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.644287] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.653054] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.661819] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.670583] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.679345] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.688111] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.696876] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.705641] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.714406] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.723170] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.731936] pin18, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.740700] pin19, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.749464] pin1a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.758229] pin1b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.766993] pin1c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.775756] pin1d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.784524] pin1e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.793281] pin1f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.802046] pin20, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.810809] pin21, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.819575] pin22, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.828341] pin23, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.837104] pin24, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.845868] pin25, enabled , level, low , V(22), IRR(0), S(0), logical , D(08), M(0) kern :debug : [ 21.854632] pin26, enabled , level, low , V(22), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 21.863396] pin27, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.872162] pin28, disabled, edge , high, V(F6), IRR(0), S(0), logical , D(CB), M(2) kern :debug : [ 21.880925] pin29, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.889689] pin2a, enabled , level, low , V(22), IRR(0), S(0), logical , D(02), M(0) kern :debug : [ 21.898455] pin2b, enabled , level, low , V(22), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 21.907220] pin2c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.915988] pin2d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.924744] pin2e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.933509] pin2f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.942273] pin30, enabled , level, low , V(21), IRR(0), S(0), logical , D(08), M(0) kern :debug : [ 21.951038] pin31, enabled , level, low , V(21), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 21.959802] pin32, enabled , level, low , V(21), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 21.968568] pin33, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.977333] pin34, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.986097] pin35, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.994862] pin36, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.003627] pin37, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.012393] pin38, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.021158] pin39, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.029922] pin3a, disabled, edge , high, V(7D), IRR(0), S(0), logical , D(FF), M(2) kern :debug : [ 22.038687] pin3b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.047454] pin3c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.056220] pin3d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.064986] pin3e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.073751] pin3f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.082517] pin40, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.091281] pin41, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.100047] pin42, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.108810] pin43, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.117573] pin44, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.126337] pin45, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.135101] pin46, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.143864] pin47, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.152628] pin48, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.161392] pin49, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.170159] pin4a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.178926] pin4b, disabled, edge , high, V(7C), IRR(0), S(0), logical , D(B3), M(2) kern :debug : [ 22.187691] pin4c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.196457] pin4d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.205222] pin4e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.213986] pin4f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.222751] pin50, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.231514] pin51, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.240278] pin52, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.249042] pin53, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.257806] pin54, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.266569] pin55, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.275333] pin56, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.284092] IRQ to pin mappings: kern :debug : [ 22.287688] IRQ0 -> 0:2 kern :debug : [ 22.290425] IRQ1 -> 0:1 kern :debug : [ 22.293161] IRQ3 -> 0:3 kern :debug : [ 22.295884] IRQ4 -> 0:4 kern :debug : [ 22.298619] IRQ5 -> 0:5 kern :debug : [ 22.301346] IRQ6 -> 0:6 kern :debug : [ 22.304085] IRQ7 -> 0:7 kern :debug : [ 22.306815] IRQ8 -> 0:8 kern :debug : [ 22.309551] IRQ9 -> 0:9 kern :debug : [ 22.312278] IRQ10 -> 0:10 kern :debug : [ 22.315204] IRQ11 -> 0:11 kern :debug : [ 22.318133] IRQ12 -> 0:12 kern :debug : [ 22.321064] IRQ13 -> 0:13 kern :debug : [ 22.323990] IRQ14 -> 0:14 kern :debug : [ 22.326919] IRQ15 -> 0:15 kern :debug : [ 22.329842] IRQ16 -> 0:16 kern :debug : [ 22.332772] IRQ17 -> 0:17 kern :debug : [ 22.335689] IRQ18 -> 0:18 kern :debug : [ 22.338618] IRQ19 -> 0:19 kern :debug : [ 22.341540] IRQ20 -> 0:20 kern :debug : [ 22.344471] IRQ24 -> 0:24 kern :debug : [ 22.347387] IRQ25 -> 0:25 kern :debug : [ 22.350317] IRQ26 -> 0:26 kern :debug : [ 22.353247] IRQ27 -> 0:27 kern :debug : [ 22.356169] IRQ28 -> 0:28 kern :debug : [ 22.359094] IRQ29 -> 0:29 kern :debug : [ 22.362024] IRQ37 -> 0:37 kern :debug : [ 22.364953] IRQ38 -> 0:38 kern :debug : [ 22.367878] IRQ39 -> 0:39 kern :debug : [ 22.370808] IRQ40 -> 0:40 kern :debug : [ 22.373737] IRQ41 -> 0:41 kern :debug : [ 22.376668] IRQ42 -> 0:42 kern :debug : [ 22.379594] IRQ43 -> 0:43 kern :debug : [ 22.382523] IRQ44 -> 0:44 kern :debug : [ 22.385454] IRQ46 -> 0:46 kern :debug : [ 22.388375] IRQ47 -> 0:47 kern :debug : [ 22.391300] IRQ48 -> 0:48 kern :debug : [ 22.394230] IRQ49 -> 0:49 kern :debug : [ 22.397151] IRQ50 -> 0:50 kern :info : [ 22.400075] .................................... done. kern :info : [ 22.405827] sched_clock: Marking stable (22405808380, 0)->(22566177156, -160368776) kern :info : [ 22.419134] registered taskstats version 1 kern :notice: [ 22.423726] Loading compiled-in X.509 certificates kern :notice: [ 22.438241] Loaded X.509 cert 'Build time autogenerated kernel key: 34d4ca7bc7e4c62ceb42b3558cd8900bf870ea7b' kern :info : [ 22.449394] zswap: loaded using pool lzo/zbud kern :notice: [ 22.459725] Key type trusted registered kern :notice: [ 22.471227] Key type encrypted registered kern :info : [ 22.475729] AppArmor: AppArmor sha1 policy hashing enabled kern :info : [ 22.481871] ima: No TPM chip found, activating TPM-bypass! (rc=-19) kern :info : [ 22.488893] ima: Allocated hash algorithm: sha1 kern :info : [ 22.494004] evm: HMAC attrs: 0x1 kern :info : [ 22.498385] Magic number: 1:940:938 kern :info : [ 22.502572] dma dma0chan3: hash matches kern :info : [ 22.507387] rtc_cmos 00:00: setting system clock to 2017-09-22 13:57:02 UTC (1506088622) kern :info : [ 22.538566] Freeing unused kernel memory: 1712K kern :info : [ 22.560413] Write protecting the kernel read-only data: 18432k kern :info : [ 22.569497] Freeing unused kernel memory: 2008K kern :info : [ 22.576264] Freeing unused kernel memory: 104K daemon:info : [ 22.620182] systemd-udevd[116]: starting version 208 kern :notice: [ 22.626581] random: systemd-udevd: uninitialized urandom read (4 bytes read) kern :info : [ 22.661672] sdhci: Secure Digital Host Controller Interface driver kern :info : [ 22.668607] sdhci: Copyright(c) Pierre Ossman kern :info : [ 22.668705] 80860F0A:00: ttyS4 at MMIO 0x90c15000 (irq = 39, base_baud = 6250000) is a 16550A kern :debug : [ 22.686559] evbug: Connected device: input0 (Power Button at PNP0C0C/button/input0) kern :debug : [ 22.695138] evbug: Connected device: input1 (Sleep Button at PNP0C0E/button/input0) kern :debug : [ 22.703712] evbug: Connected device: input2 (Power Button at LNXPWRBN/button/input0) kern :info : [ 22.752124] dca service started, version 1.12.1 kern :debug : [ 22.759916] IOAPIC[0]: Set routing entry (2-21 -> 0xef -> IRQ 21 Mode:1 Active:1 Dest:1) kern :info : [ 22.785907] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k kern :info : [ 22.786827] mmc0: SDHCI controller on ACPI [80860F14:01] using ADMA kern :info : [ 22.793724] igb: Copyright (c) 2007-2014 Intel Corporation. kern :info : [ 22.807964] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt kern :info : [ 22.811954] mmc1: SDHCI controller on ACPI [INT33BB:00] using ADMA kern :info : [ 22.840297] 80860F0A:01: ttyS5 at MMIO 0x90c17000 (irq = 40, base_baud = 6250000) is a 16550A kern :warn : [ 22.868764] sdhci-acpi 80860F16:00: failed to setup card detect gpio kern :info : [ 22.883450] mmc2: SDHCI controller on ACPI [80860F16:00] using ADMA kern :info : [ 22.903816] input: PC Speaker as /devices/platform/pcspkr/input/input3 kern :debug : [ 22.915390] evbug: Connected device: input3 (PC Speaker at isa0061/input0) kern :info : [ 22.959646] mmc2: new high speed SDHC card at address aaaa kern :info : [ 22.966782] cryptd: max_cpu_qlen set to 1000 kern :info : [ 22.972673] [drm] Replacing VGA console driver kern :info : [ 22.994957] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). kern :info : [ 23.002393] [drm] Driver supports precise vblank timestamp query. kern :info : [ 23.010088] iTCO_vendor_support: vendor-support=0 kern :info : [ 23.015606] SSE version of gcm_enc/dec engaged. kern :info : [ 23.022134] i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem kern :info : [ 23.034603] mmcblk2: mmc2:aaaa SL32G 29.7 GiB kern :debug : [ 23.039980] sof-audio-acpi 80860F28:01: ACPI DSP detected kern :info : [ 23.046256] sof-audio-acpi 80860F28:01: BYT-CR not detected kern :debug : [ 23.052895] sof-audio-acpi 80860F28:01: created machine bytcr_rt5651 kern :info : [ 23.057666] mmcblk2: p1 p2 p3 p4 kern :info : [ 23.060138] sof-audio-acpi 80860F28:01: info: loading firmware intel/sof-byt.ri kern :debug : [ 23.072252] sof-audio sof-audio: probing SOF DSP device.... kern :info : [ 23.075034] [drm] Initialized i915 1.6.0 20180308 for 0000:00:02.0 on minor 0 kern :debug : [ 23.078597] sof-audio sof-audio: using platform alias sst-mfld-platform kern :info : [ 23.087895] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) kern :debug : [ 23.094012] sof-audio sof-audio: LPE PHY base at 0x90a00000 size 0x200000 kern :info : [ 23.102535] acpi device:30: registered as cooling_device4 kern :info : [ 23.109297] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 kern :debug : [ 23.109330] sof-audio sof-audio: LPE VADDR (ptrval) kern :debug : [ 23.109334] sof-audio sof-audio: IMR base at 0x20000000 size 0x100000 kern :debug : [ 23.109353] sof-audio sof-audio: IMR VADDR (ptrval) kern :debug : [ 23.109357] sof-audio sof-audio: using IRQ 29 kern :info : [ 23.110829] pps pps0: new PPS source ptp0 kern :info : [ 23.110834] igb 0000:03:00.0: added PHC on eth0 kern :info : [ 23.110836] igb 0000:03:00.0: Intel(R) Gigabit Ethernet Network Connection kern :info : [ 23.110839] igb 0000:03:00.0: eth0: (PCIe:2.5Gb/s:Width x1) 00:08:a2:0c:f4:37 kern :info : [ 23.110896] igb 0000:03:00.0: eth0: PBA No: 000300-000 kern :info : [ 23.110899] igb 0000:03:00.0: Using MSI-X interrupts. 4 rx queue(s), 4 tx queue(s) kern :info : [ 23.115431] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input4 kern :debug : [ 23.121656] sof-audio sof-audio: pre-allocate 8 IPC messages kern :info : [ 23.121671] iTCO_wdt: Found a Bay Trail SoC TCO device (Version=3, TCOBASE=0x0460) kern :info : [ 23.121861] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0) kern :debug : [ 23.128890] evbug: Connected device: input4 (Video Bus at LNXVIDEO/video/input0) kern :debug : [ 23.135151] sof-audio sof-audio: loading firmware kern :notice: [ 23.150925] random: fast init done kern :debug : [ 23.155917] sof-audio sof-audio: header size=0x11a45 modules=0x1 abi=0x1 size=16 kern :info : [ 23.218174] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :debug : [ 23.226016] sof-audio sof-audio: new module size 0x11a39 blocks 0xe type 0x0 kern :info : [ 23.231175] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :info : [ 23.231208] bytcr_rt5651 bytcr_rt5651: ASoC: CPU DAI media-cpu-dai not registered kern :debug : [ 23.235110] sof-audio sof-audio: block 0 type 0x1 size 0x160 ==> offset 0xc0000 kern :err : [ 23.243289] bytcr_rt5651 bytcr_rt5651: devm_snd_soc_register_card failed -517 kern :debug : [ 23.289694] sof-audio sof-audio: block 1 type 0x1 size 0x16a ==> offset 0xc0400 kern :debug : [ 23.298146] sof-audio sof-audio: block 2 type 0x1 size 0x6 ==> offset 0xc057c kern :debug : [ 23.306352] sof-audio sof-audio: block 3 type 0x1 size 0x6 ==> offset 0xc059c kern :debug : [ 23.314471] sof-audio sof-audio: block 4 type 0x1 size 0x6 ==> offset 0xc05bc kern :debug : [ 23.322557] sof-audio sof-audio: block 5 type 0x1 size 0x6 ==> offset 0xc05dc kern :debug : [ 23.330691] sof-audio sof-audio: block 6 type 0x1 size 0x3 ==> offset 0xc061c kern :debug : [ 23.338802] sof-audio sof-audio: block 7 type 0x1 size 0x6 ==> offset 0xc063c kern :debug : [ 23.346899] sof-audio sof-audio: block 8 type 0x1 size 0x4 ==> offset 0xc0658 kern :debug : [ 23.354996] sof-audio sof-audio: block 9 type 0x1 size 0x17 ==> offset 0xc065c kern :debug : [ 23.363188] sof-audio sof-audio: block 10 type 0x1 size 0x6 ==> offset 0xc067c kern :debug : [ 23.371382] sof-audio sof-audio: block 11 type 0x1 size 0xed9d ==> offset 0xc06a0 kern :debug : [ 23.387783] sof-audio sof-audio: block 12 type 0x2 size 0x1d10 ==> offset 0x100008 kern :debug : [ 23.397321] sof-audio sof-audio: block 13 type 0x2 size 0xbd8 ==> offset 0x101d18 kern :debug : [ 23.406190] sof-audio sof-audio: booting DSP firmware kern :debug : [ 23.413145] sof-audio sof-audio: ipc: DSP is ready 0x70000000 offset 0x144000 kern :info : [ 23.421179] sof-audio sof-audio: Firmware info: version 1:1-2a488 build 43 on Oct 17 2018:19:04:26 kern :debug : [ 23.431447] sof-audio sof-audio: found ext header type 1 size 0x88 kern :info : [ 23.432154] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :debug : [ 23.438490] sof-audio sof-audio: mailbox upstream 0x144000 - size 0x400 kern :info : [ 23.445393] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :info : [ 23.445410] bytcr_rt5651 bytcr_rt5651: ASoC: CPU DAI media-cpu-dai not registered kern :debug : [ 23.452912] sof-audio sof-audio: mailbox downstream 0x144400 - size 0x400 kern :err : [ 23.459244] bytcr_rt5651 bytcr_rt5651: devm_snd_soc_register_card failed -517 kern :debug : [ 23.467611] sof-audio sof-audio: stream region 0x144a00 - size 0x200 kern :debug : [ 23.467615] sof-audio sof-audio: booting DSP firmware completed kern :debug : [ 23.497102] sof-audio sof-audio: ipc rx: 0x70000000 done kern :info : [ 23.497486] sof-audio sof-audio: firmware boot complete kern :debug : [ 23.508972] sof-audio sof-audio: generating page table for (ptrval) size 0x10000 pages 16 kern :debug : [ 23.518906] sof-audio sof-audio: pfn i 0 idx 0 pfn 747f0 kern :debug : [ 23.524858] sof-audio sof-audio: pfn i 1 idx 2 pfn 747f1 kern :debug : [ 23.530812] sof-audio sof-audio: pfn i 2 idx 5 pfn 747f2 kern :debug : [ 23.536760] sof-audio sof-audio: pfn i 3 idx 7 pfn 747f3 kern :debug : [ 23.542707] sof-audio sof-audio: pfn i 4 idx 10 pfn 747f4 kern :debug : [ 23.548748] sof-audio sof-audio: pfn i 5 idx 12 pfn 747f5 kern :debug : [ 23.554790] sof-audio sof-audio: pfn i 6 idx 15 pfn 747f6 kern :debug : [ 23.560833] sof-audio sof-audio: pfn i 7 idx 17 pfn 747f7 kern :debug : [ 23.566875] sof-audio sof-audio: pfn i 8 idx 20 pfn 747f8 kern :debug : [ 23.572918] sof-audio sof-audio: pfn i 9 idx 22 pfn 747f9 kern :debug : [ 23.578960] sof-audio sof-audio: pfn i 10 idx 25 pfn 747fa kern :debug : [ 23.585101] sof-audio sof-audio: pfn i 11 idx 27 pfn 747fb kern :debug : [ 23.591241] sof-audio sof-audio: pfn i 12 idx 30 pfn 747fc kern :debug : [ 23.597381] sof-audio sof-audio: pfn i 13 idx 32 pfn 747fd kern :debug : [ 23.603519] sof-audio sof-audio: pfn i 14 idx 35 pfn 747fe kern :debug : [ 23.609660] sof-audio sof-audio: pfn i 15 idx 37 pfn 747ff kern :debug : [ 23.615801] sof-audio sof-audio: dma_trace_pages: 16 kern :debug : [ 23.621368] sof-audio sof-audio: stream_tag: -26922 kern :warn : [ 23.623265] intel_soc_dts_thermal: request_threaded_irq ret -22 kern :debug : [ 23.626862] sof-audio sof-audio: ipc: send 0x90010000 kern :debug : [ 23.639143] sof-audio sof-audio: ipc: 0x90010000 succeeded kern :info : [ 23.645410] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :info : [ 23.645585] intel_rapl: Found RAPL domain package kern :info : [ 23.652431] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :info : [ 23.652444] bytcr_rt5651 bytcr_rt5651: info: override FE DAI link SSP2-Codec kern :info : [ 23.663495] intel_rapl: Found RAPL domain core kern :warn : [ 23.665914] rt5651 i2c-10EC5651:00: Warning: Invalid over-current-threshold-microamp value: 0, defaulting to 2000uA kern :info : [ 23.684293] [drm] Cannot find any crtc or sizes kern :debug : [ 23.688883] sof-audio sof-audio: loading topology:intel/sof-byt-rt5651.tplg kern :debug : [ 23.701555] sof-audio sof-audio: tplg: ready widget id 0 pipe 1 type 23 name : PCM0P stream Passthrough Playback 0 kern :debug : [ 23.713155] sof-audio sof-audio: loaded host PCM0P kern :debug : [ 23.718537] sof-audio sof-audio: config: periods snk 2 src 0 fmt 0 kern :debug : [ 23.725593] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.731300] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.737465] sof-audio sof-audio: tplg: load control type 1 name : Master Playback Volume 1 kern :debug : [ 23.746727] sof-audio sof-audio: tplg: load kcontrol index 1 chans 2 kern :debug : [ 23.753851] sof-audio sof-audio: tplg: ready widget id 1 pipe 1 type 6 name : PGA1.0 stream kern :debug : [ 23.763326] sof-audio sof-audio: config: periods snk 2 src 2 fmt 0 kern :debug : [ 23.770378] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.776072] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.782249] sof-audio sof-audio: tplg: ready widget id 2 pipe 1 type 31 name : BUF1.0 stream kern :debug : [ 23.791810] sof-audio sof-audio: buffer BUF1.0: size 384 caps 0x61 kern :debug : [ 23.798752] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 23.804444] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 23.810602] sof-audio sof-audio: tplg: ready widget id 3 pipe 1 type 31 name : BUF1.1 stream kern :debug : [ 23.820156] sof-audio sof-audio: buffer BUF1.1: size 384 caps 0x61 kern :debug : [ 23.827111] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 23.832805] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 23.838965] sof-audio sof-audio: tplg: ready widget id 4 pipe 1 type 27 name : SSP2.OUT stream SSP2-Codec kern :debug : [ 23.849709] sof-audio sof-audio: dai SSP2.OUT: type 1 index 2 kern :debug : [ 23.856171] sof-audio sof-audio: config: periods snk 0 src 2 fmt 0 kern :debug : [ 23.863228] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.868924] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.875079] sof-audio sof-audio: tplg: check widget: SSP2.OUT stream: SSP2-Codec dai stream: SSP2-Codec kern :debug : [ 23.885592] sof-audio sof-audio: tplg: connected widget SSP2.OUT -> DAI link SSP2-Codec kern :debug : [ 23.894555] sof-audio sof-audio: tplg: ready widget id 5 pipe 1 type 32 name : PIPELINE.1.SSP2.OUT stream SSP2.OUT kern :debug : [ 23.906137] sof-audio sof-audio: tplg: pipeline id 1 comp 5 scheduling comp id 4 kern :debug : [ 23.914415] sof-audio sof-audio: pipeline PIPELINE.1.SSP2.OUT: deadline 1000 pri 0 mips 5000 core 0 frames 48 kern :debug : [ 23.925531] sof-audio sof-audio: ipc: send 0x30100000 kern :debug : [ 23.931208] sof-audio sof-audio: ipc: 0x30100000 succeeded kern :info : [ 23.936018] raid6: sse2x1 gen() 1251 MB/s kern :debug : [ 23.937346] sof-audio sof-audio: tplg: ready widget id 6 pipe 2 type 24 name : PCM0C stream Passthrough Capture 0 kern :debug : [ 23.953586] sof-audio sof-audio: loaded host PCM0C kern :debug : [ 23.958948] sof-audio sof-audio: config: periods snk 0 src 2 fmt 0 kern :debug : [ 23.965980] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.971656] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.977803] sof-audio sof-audio: tplg: load control type 1 name : Master Capture Volume 2 kern :debug : [ 23.986954] sof-audio sof-audio: tplg: load kcontrol index 7 chans 2 kern :debug : [ 23.994066] sof-audio sof-audio: tplg: ready widget id 7 pipe 2 type 6 name : PGA2.0 stream kern :debug : [ 24.003517] sof-audio sof-audio: config: periods snk 2 src 2 fmt 0 kern :info : [ 24.008014] raid6: sse2x1 xor() 1933 MB/s kern :debug : [ 24.010553] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 24.020971] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 24.027117] sof-audio sof-audio: tplg: ready widget id 8 pipe 2 type 31 name : BUF2.0 stream kern :debug : [ 24.036658] sof-audio sof-audio: buffer BUF2.0: size 384 caps 0x61 kern :debug : [ 24.043589] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 24.049265] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 24.055410] sof-audio sof-audio: tplg: ready widget id 9 pipe 2 type 31 name : BUF2.1 stream kern :debug : [ 24.064950] sof-audio sof-audio: buffer BUF2.1: size 384 caps 0x61 kern :debug : [ 24.071879] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 24.077554] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :info : [ 24.080024] raid6: sse2x2 gen() 2091 MB/s kern :debug : [ 24.083700] sof-audio sof-audio: tplg: ready widget id 10 pipe 2 type 28 name : SSP2.IN stream SSP2-Codec kern :debug : [ 24.099171] sof-audio sof-audio: dai SSP2.IN: type 1 index 2 kern :debug : [ 24.105503] sof-audio sof-audio: config: periods snk 2 src 0 fmt 0 kern :debug : [ 24.112535] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 24.118211] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 24.122063] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 24.124354] sof-audio sof-audio: tplg: check widget: SSP2.IN stream: SSP2-Codec dai stream: SSP2-Codec kern :debug : [ 24.140711] sof-audio sof-audio: tplg: connected widget SSP2.IN -> DAI link SSP2-Codec kern :debug : [ 24.149573] sof-audio sof-audio: tplg: ready widget id 11 pipe 2 type 32 name : PIPELINE.2.SSP2.IN stream SSP2.IN kern :info : [ 24.156019] raid6: sse2x2 xor() 2328 MB/s kern :debug : [ 24.161063] sof-audio sof-audio: tplg: pipeline id 2 comp 11 scheduling comp id 10 kern :debug : [ 24.174296] sof-audio sof-audio: pipeline PIPELINE.2.SSP2.IN: deadline 1000 pri 0 mips 5000 core 0 frames 48 kern :debug : [ 24.185320] sof-audio sof-audio: ipc: send 0x30100000 kern :debug : [ 24.190997] sof-audio sof-audio: ipc: 0x30100000 succeeded kern :debug : [ 24.197136] sof-audio sof-audio: tplg: load pcm Passthrough 0 kern :debug : [ 24.203571] sof-audio sof-audio: sink PCM0P control none source Passthrough Playback 0 kern :debug : [ 24.212453] sof-audio sof-audio: sink BUF1.0 control none source PCM0P kern :debug : [ 24.219770] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.225440] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.231587] sof-audio sof-audio: sink PGA1.0 control none source BUF1.0 kern :info : [ 24.232020] raid6: sse2x4 gen() 3209 MB/s kern :debug : [ 24.239005] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.249428] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.255575] sof-audio sof-audio: sink BUF1.1 control none source PGA1.0 kern :debug : [ 24.262993] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.268663] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.274810] sof-audio sof-audio: sink Passthrough Capture 0 control none source PCM0C kern :debug : [ 24.283578] sof-audio sof-audio: sink PCM0C control none source BUF2.0 kern :debug : [ 24.290900] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.296571] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.302717] sof-audio sof-audio: sink BUF2.0 control none source PGA2.0 kern :info : [ 24.308017] raid6: sse2x4 xor() 2248 MB/s kern :debug : [ 24.310135] sof-audio sof-audio: ipc: send 0x30030000 kern :info : [ 24.314890] raid6: using algorithm sse2x4 gen() 3209 MB/s kern :debug : [ 24.320574] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :info : [ 24.326576] raid6: .... xor() 2248 MB/s, rmw enabled kern :debug : [ 24.332722] sof-audio sof-audio: sink PGA2.0 control none source BUF2.1 kern :info : [ 24.338263] raid6: using ssse3x2 recovery algorithm kern :debug : [ 24.345677] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.356802] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.362970] sof-audio sof-audio: sink SSP2.OUT control none source BUF1.1 kern :info : [ 24.363068] xor: measuring software checksum speed kern :debug : [ 24.370594] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.381604] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.387759] sof-audio sof-audio: sink BUF2.1 control none source SSP2.IN kern :debug : [ 24.395284] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.400962] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.407126] sof-audio sof-audio: tplg: config SSP0 fmt 0x4001 mclk 19200000 bclk 1920000 fclk 48000 width (16)20 slots 2 mclk id 0 kern :info : [ 24.412006] prefetch64-sse: 5895.000 MB/sec kern :debug : [ 24.420301] sof-audio sof-audio: ipc: send 0x80010000 kern :debug : [ 24.431001] sof-audio sof-audio: ipc: 0x80010000 succeeded kern :warn : [ 24.437153] sof-audio sof-audio: ASoC: Parent card not yet available, widget card binding deferred kern :debug : [ 24.447191] sof-audio sof-audio: tplg: complete pipeline PIPELINE.2.SSP2.IN id 11 kern :debug : [ 24.455588] sof-audio sof-audio: ipc: send 0x30130000 kern :debug : [ 24.461257] sof-audio sof-audio: ipc: 0x30130000 succeeded kern :info : [ 24.464006] generic_sse: 5354.000 MB/sec kern :debug : [ 24.467408] sof-audio sof-audio: tplg: complete pipeline PIPELINE.1.SSP2.OUT id 5 kern :info : [ 24.472168] xor: using function: prefetch64-sse (5895.000 MB/sec) kern :debug : [ 24.487389] sof-audio sof-audio: ipc: send 0x30130000 kern :debug : [ 24.493075] sof-audio sof-audio: ipc: 0x30130000 succeeded kern :info : [ 24.499445] bytcr_rt5651 bytcr_rt5651: rt5651-aif1 <-> ssp2-port mapping ok kern :debug : [ 24.507325] sof-audio sof-audio: creating new PCM Passthrough kern :debug : [ 24.513770] sof-audio sof-audio: spcm: allocate Passthrough Playback 0 playback DMA buffer size 0x10000 max 0x10000 kern :debug : [ 24.525516] sof-audio sof-audio: spcm: allocate Passthrough Capture 0 capture DMA buffer size 0x10000 max 0x10000 kern :info : [ 24.537044] bytcr_rt5651 bytcr_rt5651: snd-soc-dummy-dai <-> Passthrough 0 mapping ok kern :debug : [ 24.618891] sof-audio sof-audio: ipc rx: 0x90020000 done kern :info : [ 24.634563] Btrfs loaded, crc32c=crc32c-intel kern :info : [ 24.796220] [drm] Cannot find any crtc or sizes kern :info : [ 24.850440] BTRFS: device label LKP-ROOTFS devid 1 transid 1766 /dev/mmcblk2p4 kern :info : [ 25.007847] BTRFS info (device mmcblk2p4): disk space caching is enabled kern :info : [ 25.045235] BTRFS info (device mmcblk2p4): enabling ssd optimizations kern :info : [ 25.360089] [drm] Cannot find any crtc or sizes daemon:info : [ 28.544243] systemd[1]: RTC configured in localtime, applying delta of 480 minutes to system time. daemon:info : [ 28.554923] systemd[1]: System time before build time, advancing clock. kern :notice: [ 28.948250] random: systemd: uninitialized urandom read (16 bytes read) kern :notice: [ 28.976740] random: systemd: uninitialized urandom read (16 bytes read) kern :notice: [ 29.000710] random: systemd: uninitialized urandom read (16 bytes read) kern :info : [ 29.422540] RPC: Registered named UNIX socket transport module. kern :info : [ 29.430420] RPC: Registered udp transport module. kern :info : [ 29.430421] RPC: Registered tcp transport module. kern :info : [ 29.430422] RPC: Registered tcp NFSv4.1 backchannel transport module. kern :info : [ 29.479816] lp: driver loaded but no devices found kern :info : [ 29.492232] ppdev: user-space parallel port driver kern :info : [ 44.056444] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready kern :info : [ 44.113167] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready kern :info : [ 46.860643] igb 0000:03:00.0 eth0: igb: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX kern :info : [ 46.871221] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready user :notice: [ 59.900075] Kernel tests: Boot OK! kern :info : [ 64.048857] netpoll: netconsole: local port 6665 kern :info : [ 64.054063] netpoll: netconsole: local IPv4 address 0.0.0.0 kern :info : [ 64.060342] netpoll: netconsole: interface 'eth0' kern :info : [ 64.065634] netpoll: netconsole: remote port 6653 kern :info : [ 64.070915] netpoll: netconsole: remote IPv4 address 192.168.1.1 kern :info : [ 64.077653] netpoll: netconsole: remote ethernet address ff:ff:ff:ff:ff:ff kern :info : [ 64.085563] netpoll: netconsole: local IP 192.168.1.215 kern :info : [ 64.091555] console [netcon0] enabled kern :info : [ 64.095696] netconsole: network logging started kern :notice: [ 64.431164] FS-Cache: Loaded kern :notice: [ 64.470955] FS-Cache: Netfs 'nfs' registered for caching user :notice: [ 71.212915] 18 Oct 03:16:43 ntpdate[860]: step time server 192.168.1.1 offset 30777701.619716 sec user :notice: [ 71.226699] /lkp/lkp/src/bin/run-lkp kern :notice: [ 77.344960] random: crng init done kern :notice: [ 77.348783] random: 6 urandom warning(s) missed due to ratelimiting user :notice: [ 84.170566] RESULT_ROOT=/result/sof_test/defaults/sof-minnow/ubuntu-x86_64-2018-02-07-sof/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/2a48810debefed56ad2ae17061c975410ddaa290/7f47792cbd22886d5fe2acbd229a13a6ea138e66/0 user :notice: [ 84.210511] job=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml user :notice: [ 84.230611] mount.nfs: try 1 time... user :notice: [ 84.250991] run-job /lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml user :notice: [ 90.094233] /usr/bin/wget -q --local-encoding=UTF-8 --retry-connrefused --waitretry 1000 --tries 1000 http://inn:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_file=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml&job_state=running -O /dev/null user :notice: [ 90.130595] target ucode: user :notice: [ 90.141674] IPMI BMC is not supported on this machine, skip bmc-watchdog setup! user :notice: [ 90.157130] current path is = /lkp/benchmarks/sof_test/audio_sof_test.git user :notice: [ 90.178362] whereis alsabat : alsabat: /usr/bin/alsabat /lkp/benchmarks/sof_test/installation/bin/alsabat /usr/share/man/man1/alsabat.1.gz user :notice: [ 90.197358] whereis rmbox : rmbox: /usr/bin/rmbox user :notice: [ 191.864911] verify_sof_firmware_presence PASS user :notice: [ 195.361643] verify_sof_firmware_load PASS user :err : [ 197.473033] Found hardware: "sof-bytcr-rt565" "" "" "" "" user :notice: [ 197.580743] verify_sof_firmware_version_info PASS user :err : [ 197.602773] Hardware is initialized using a generic method user :notice: [ 200.592523] playack_pcm_list PASS user :err : [ 202.699715] alsactl: set_control:1325: failed to obtain info for control #22 (No such file or directory) user :err : [ 202.720398] alsactl: set_control:1325: failed to obtain info for control #23 (No such file or directory) user :notice: [ 202.858815] verify_sound_modules PASS user :notice: [ 208.712287] capture_pcm_list PASS user :notice: [ 218.615528] verify_playback_pcm_list PASS kern :debug : [ 221.430092] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 221.436189] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 221.442843] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 221.448915] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 221.455141] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 221.461891] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 221.468641] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 user :err : [ 221.472305] Playing raw data '/dev/zero' : Signed 16 bit Little Endian, Rate 48000 Hz, Stereo kern :debug : [ 221.475379] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 221.493326] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 221.500060] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 221.507165] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 221.513960] sof-audio sof-audio: generating page table for 000000006a965ff6 size 0xff00 pages 16 kern :debug : [ 221.524171] sof-audio sof-audio: pfn i 0 idx 0 pfn 740e0 kern :debug : [ 221.530424] sof-audio sof-audio: pfn i 1 idx 2 pfn 740e1 kern :debug : [ 221.536641] sof-audio sof-audio: pfn i 2 idx 5 pfn 740e2 kern :debug : [ 221.542598] sof-audio sof-audio: pfn i 3 idx 7 pfn 740e3 kern :debug : [ 221.548821] sof-audio sof-audio: pfn i 4 idx 10 pfn 740e4 kern :debug : [ 221.554875] sof-audio sof-audio: pfn i 5 idx 12 pfn 740e5 kern :debug : [ 221.561232] sof-audio sof-audio: pfn i 6 idx 15 pfn 740e6 kern :debug : [ 221.567626] sof-audio sof-audio: pfn i 7 idx 17 pfn 740e7 kern :debug : [ 221.573941] sof-audio sof-audio: pfn i 8 idx 20 pfn 740e8 kern :debug : [ 221.580332] sof-audio sof-audio: pfn i 9 idx 22 pfn 740e9 kern :debug : [ 221.586574] sof-audio sof-audio: pfn i 10 idx 25 pfn 740ea kern :debug : [ 221.592982] sof-audio sof-audio: pfn i 11 idx 27 pfn 740eb kern :debug : [ 221.599477] sof-audio sof-audio: pfn i 12 idx 30 pfn 740ec kern :debug : [ 221.605887] sof-audio sof-audio: pfn i 13 idx 32 pfn 740ed kern :debug : [ 221.612422] sof-audio sof-audio: pfn i 14 idx 35 pfn 740ee kern :debug : [ 221.618663] sof-audio sof-audio: pfn i 15 idx 37 pfn 740ef kern :debug : [ 221.625070] sof-audio sof-audio: stream_tag 0 kern :debug : [ 221.630566] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 221.636612] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 222.044021] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 222.051113] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 222.056944] sof-audio sof-audio: ipc: 0x60040000 succeeded kern :debug : [ 222.119023] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 222.693040] sof-audio sof-audio: PCM: stream 0 dir 0 DMA position 0 DAI position 0 kern :debug : [ 223.232940] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 223.240034] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 223.245891] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc user :err : [ 223.249186] aplay: pcm_write:2051: write error: Input/output error kern :err : [ 223.253527] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 223.267795] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 223.274489] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 223.280740] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 223.287386] sof-audio sof-audio: pcm: close stream 0 dir 0 user :notice: [ 223.298067] Aplay FAIL user :notice: [ 223.305514] check_aplay FAIL kern :debug : [ 223.884715] sof-audio sof-audio: ipc rx: 0x90020000 done user :notice: [ 232.865972] check_dma_trace PASS kern :debug : [ 235.203242] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 235.209019] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 235.215336] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 235.221045] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 235.483390] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 237.254048] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 237.260191] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 237.266846] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 237.272615] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 237.278658] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 237.285400] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 237.292142] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 237.298688] sof-audio sof-audio: generating page table for 000000006a965ff6 size 0xff00 pages 16 kern :debug : [ 237.308535] sof-audio sof-audio: pfn i 0 idx 0 pfn 740e0 kern :debug : [ 237.314495] sof-audio sof-audio: pfn i 1 idx 2 pfn 740e1 kern :debug : [ 237.320454] sof-audio sof-audio: pfn i 2 idx 5 pfn 740e2 kern :debug : [ 237.326404] sof-audio sof-audio: pfn i 3 idx 7 pfn 740e3 kern :debug : [ 237.332364] sof-audio sof-audio: pfn i 4 idx 10 pfn 740e4 kern :debug : [ 237.338420] sof-audio sof-audio: pfn i 5 idx 12 pfn 740e5 kern :debug : [ 237.344476] sof-audio sof-audio: pfn i 6 idx 15 pfn 740e6 kern :debug : [ 237.350532] sof-audio sof-audio: pfn i 7 idx 17 pfn 740e7 kern :debug : [ 237.356588] sof-audio sof-audio: pfn i 8 idx 20 pfn 740e8 kern :debug : [ 237.362643] sof-audio sof-audio: pfn i 9 idx 22 pfn 740e9 kern :debug : [ 237.368699] sof-audio sof-audio: pfn i 10 idx 25 pfn 740ea kern :debug : [ 237.374855] sof-audio sof-audio: pfn i 11 idx 27 pfn 740eb kern :debug : [ 237.381008] sof-audio sof-audio: pfn i 12 idx 30 pfn 740ec kern :debug : [ 237.387161] sof-audio sof-audio: pfn i 13 idx 32 pfn 740ed kern :debug : [ 237.393314] sof-audio sof-audio: pfn i 14 idx 35 pfn 740ee kern :debug : [ 237.399467] sof-audio sof-audio: pfn i 15 idx 37 pfn 740ef kern :debug : [ 237.405619] sof-audio sof-audio: stream_tag 0 kern :debug : [ 237.410544] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 237.416215] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 237.463351] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 237.475989] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.483030] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 237.488708] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.496370] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.502037] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.508983] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 237.514653] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 237.522322] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.528469] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.535452] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 237.542038] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.549767] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.555459] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.562433] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 237.568101] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 237.575775] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.581594] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.588594] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 237.594841] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.602573] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.608258] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.615209] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 237.620878] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 237.628615] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.634458] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.641423] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 237.647091] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.654781] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.660450] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.667410] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 237.673075] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc user :err : [ 237.676935] /lkp/benchmarks/sof_test/audio_sof_test.git/functionality_test/check_dma_trace.sh: line 2: 1243 Killed rmbox -t > rmbox.log kern :err : [ 237.680736] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.703594] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.711030] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 237.716212] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 237.716694] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.730694] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.736349] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.743879] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 237.749542] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :debug : [ 237.750670] sof-audio sof-audio: pcm: open stream 0 dir 1 kern :err : [ 237.757468] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.757665] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.763635] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 237.769276] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 237.769763] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :debug : [ 237.776260] sof-audio sof-audio: period count 2 max 16 kern :err : [ 237.782898] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.788553] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 237.796156] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.796171] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 237.802092] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :err : [ 237.807577] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 237.807602] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.813455] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 237.820480] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.826082] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 237.832806] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 237.840416] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :err : [ 237.846062] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.846099] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.852806] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 237.859970] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.860295] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 237.866830] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :err : [ 237.872963] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :debug : [ 237.879230] sof-audio sof-audio: pcm: hw params stream 0 dir 1 kern :err : [ 237.886926] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.892528] sof-audio sof-audio: generating page table for 0000000025e8c29f size 0xff00 pages 16 kern :debug : [ 237.899369] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 237.906175] sof-audio sof-audio: pfn i 0 idx 0 pfn 73d00 kern :debug : [ 237.906183] sof-audio sof-audio: pfn i 1 idx 2 pfn 73d01 kern :debug : [ 237.906185] sof-audio sof-audio: pfn i 2 idx 5 pfn 73d02 kern :debug : [ 237.906190] sof-audio sof-audio: pfn i 3 idx 7 pfn 73d03 kern :debug : [ 237.911875] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 237.918594] sof-audio sof-audio: pfn i 4 idx 10 pfn 73d04 kern :err : [ 237.926194] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 237.926230] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 237.932735] sof-audio sof-audio: pfn i 5 idx 12 pfn 73d05 kern :debug : [ 237.938403] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 237.938422] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 237.948245] sof-audio sof-audio: pfn i 6 idx 15 pfn 73d06 kern :err : [ 237.955164] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 237.955190] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 237.961124] sof-audio sof-audio: pfn i 7 idx 17 pfn 73d07 kern :debug : [ 238.048134] sof-audio sof-audio: pfn i 8 idx 20 pfn 73d08 kern :debug : [ 238.054182] sof-audio sof-audio: pfn i 9 idx 22 pfn 73d09 kern :debug : [ 238.060233] sof-audio sof-audio: pfn i 10 idx 25 pfn 73d0a kern :debug : [ 238.066384] sof-audio sof-audio: pfn i 11 idx 27 pfn 73d0b kern :debug : [ 238.072532] sof-audio sof-audio: pfn i 12 idx 30 pfn 73d0c kern :debug : [ 238.078680] sof-audio sof-audio: pfn i 13 idx 32 pfn 73d0d kern :debug : [ 238.084836] sof-audio sof-audio: pfn i 14 idx 35 pfn 73d0e kern :debug : [ 238.090985] sof-audio sof-audio: pfn i 15 idx 37 pfn 73d0f kern :debug : [ 238.097133] sof-audio sof-audio: stream_tag 0 kern :debug : [ 238.102073] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 238.107948] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 238.114459] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 238.126101] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 1 kern :debug : [ 238.133358] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 238.139471] sof-audio sof-audio: ipc: 0x60040000 succeeded kern :debug : [ 238.146054] sof-audio sof-audio: PCM: stream 0 dir 1 DMA position 0 DAI position 0 kern :debug : [ 238.602574] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 238.657014] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 0 kern :debug : [ 238.664372] sof-audio sof-audio: ipc: send 0x60050000 user :err : [ 238.669522] Read PCM device error: Input/output error(-5) kern :err : [ 238.670190] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 238.685636] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 238.691344] sof-audio sof-audio: pcm: free stream 0 dir 1 kern :debug : [ 238.697762] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 238.703845] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 238.710219] sof-audio sof-audio: pcm: close stream 0 dir 1 kern :debug : [ 238.976674] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 238.983695] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 238.989485] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc user :err : [ 238.992389] Write PCM device error: Input/output error(-5) kern :err : [ 238.997121] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 239.097590] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 249.056481] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 249.063541] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 249.069759] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 249.077617] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 249.083306] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 249.089852] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 249.096021] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 249.102695] sof-audio sof-audio: pcm: close stream 0 dir 0 user :err : [ 249.114027] Exit playback thread fail: -5 user :notice: [ 249.115421] alsa-utils version 1.1.6 user :notice: [ 249.131032] Entering playback thread (ALSA). user :notice: [ 249.141459] Get period size: 2112 buffer size: 16320 user :notice: [ 249.151737] Playing generated audio sine wave user :notice: [ 249.161148] Entering capture thread (ALSA). user :notice: [ 249.171190] Get period size: 2112 buffer size: 16320 user :notice: [ 249.180019] Recording ... user :notice: [ 249.189076] Fail: line in/out mode playback test failed. user :notice: [ 249.201123] Check_volume_line_in_out_48k_dat_playback FAIL kern :debug : [ 249.871727] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 253.619032] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 253.624885] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 253.631623] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 253.637804] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 253.947339] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 255.676177] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 255.682316] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 255.689324] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 255.695342] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 255.701379] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 255.708206] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 255.715255] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 255.722067] sof-audio sof-audio: generating page table for 000000006a965ff6 size 0xff00 pages 16 kern :debug : [ 255.731918] sof-audio sof-audio: pfn i 0 idx 0 pfn 740e0 kern :debug : [ 255.737888] sof-audio sof-audio: pfn i 1 idx 2 pfn 740e1 kern :debug : [ 255.743855] sof-audio sof-audio: pfn i 2 idx 5 pfn 740e2 kern :debug : [ 255.749824] sof-audio sof-audio: pfn i 3 idx 7 pfn 740e3 kern :debug : [ 255.755792] sof-audio sof-audio: pfn i 4 idx 10 pfn 740e4 kern :debug : [ 255.761857] sof-audio sof-audio: pfn i 5 idx 12 pfn 740e5 kern :debug : [ 255.767921] sof-audio sof-audio: pfn i 6 idx 15 pfn 740e6 kern :debug : [ 255.773986] sof-audio sof-audio: pfn i 7 idx 17 pfn 740e7 kern :debug : [ 255.780046] sof-audio sof-audio: pfn i 8 idx 20 pfn 740e8 kern :debug : [ 255.786112] sof-audio sof-audio: pfn i 9 idx 22 pfn 740e9 kern :debug : [ 255.792180] sof-audio sof-audio: pfn i 10 idx 25 pfn 740ea kern :debug : [ 255.798342] sof-audio sof-audio: pfn i 11 idx 27 pfn 740eb kern :debug : [ 255.804496] sof-audio sof-audio: pfn i 12 idx 30 pfn 740ec kern :debug : [ 255.810648] sof-audio sof-audio: pfn i 13 idx 32 pfn 740ed kern :debug : [ 255.816809] sof-audio sof-audio: pfn i 14 idx 35 pfn 740ee kern :debug : [ 255.822973] sof-audio sof-audio: pfn i 15 idx 37 pfn 740ef kern :debug : [ 255.829136] sof-audio sof-audio: stream_tag 0 kern :debug : [ 255.834070] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 255.839732] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 255.846331] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 255.853301] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 255.858965] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 255.866610] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 255.872283] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 255.879235] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 255.884901] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 255.892525] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 255.898311] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 255.905276] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 255.910938] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 255.918568] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 255.924238] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 255.926936] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 255.931195] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 255.942787] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 255.950411] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 255.956216] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 255.963207] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 255.968875] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 255.976513] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 255.982171] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 255.989117] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 255.994821] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.002452] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.008246] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 256.015205] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 256.020871] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 256.028501] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.034166] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 256.041367] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 256.047292] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.055212] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.061328] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 256.068470] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 256.074151] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 256.082120] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.087787] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 256.095329] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 256.101009] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.108776] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.114579] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 256.121538] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 256.127202] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 256.134884] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.140555] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 256.147501] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 256.153493] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 256.153752] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.167179] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.167278] sof-audio sof-audio: pcm: open stream 0 dir 1 kern :debug : [ 256.173014] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 256.179032] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 256.185920] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 256.186295] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :debug : [ 256.192636] sof-audio sof-audio: period count 2 max 16 kern :err : [ 256.198303] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.205900] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 256.211657] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 256.211672] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 256.217510] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :err : [ 256.223181] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.223216] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.230131] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 256.236418] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 256.243054] sof-audio sof-audio: pcm: hw params stream 0 dir 1 kern :debug : [ 256.250965] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 256.256675] sof-audio sof-audio: generating page table for 0000000025e8c29f size 0xff00 pages 16 kern :err : [ 256.264009] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :debug : [ 256.270550] sof-audio sof-audio: pfn i 0 idx 0 pfn 73d00 kern :err : [ 256.277190] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.282778] sof-audio sof-audio: pfn i 1 idx 2 pfn 73d01 kern :debug : [ 256.292617] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 256.292635] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 256.300233] sof-audio sof-audio: pfn i 2 idx 5 pfn 73d02 kern :err : [ 256.306179] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.306202] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.311852] sof-audio sof-audio: pfn i 3 idx 7 pfn 73d03 kern :debug : [ 256.355780] sof-audio sof-audio: pfn i 4 idx 10 pfn 73d04 kern :debug : [ 256.361833] sof-audio sof-audio: pfn i 5 idx 12 pfn 73d05 kern :debug : [ 256.368128] sof-audio sof-audio: pfn i 6 idx 15 pfn 73d06 kern :debug : [ 256.374182] sof-audio sof-audio: pfn i 7 idx 17 pfn 73d07 kern :debug : [ 256.380501] sof-audio sof-audio: pfn i 8 idx 20 pfn 73d08 kern :debug : [ 256.386608] sof-audio sof-audio: pfn i 9 idx 22 pfn 73d09 kern :debug : [ 256.392924] sof-audio sof-audio: pfn i 10 idx 25 pfn 73d0a kern :debug : [ 256.399077] sof-audio sof-audio: pfn i 11 idx 27 pfn 73d0b kern :debug : [ 256.405491] sof-audio sof-audio: pfn i 12 idx 30 pfn 73d0c kern :debug : [ 256.411898] sof-audio sof-audio: pfn i 13 idx 32 pfn 73d0d kern :debug : [ 256.418377] sof-audio sof-audio: pfn i 14 idx 35 pfn 73d0e kern :debug : [ 256.424796] sof-audio sof-audio: pfn i 15 idx 37 pfn 73d0f kern :debug : [ 256.430950] sof-audio sof-audio: stream_tag 0 kern :debug : [ 256.436509] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 256.442186] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 256.474182] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 1 kern :debug : [ 256.481587] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 256.487820] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 256.495723] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 256.501410] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 0 kern :debug : [ 256.508713] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 256.514396] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 256.522169] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 256.528597] sof-audio sof-audio: pcm: free stream 0 dir 1 kern :debug : [ 256.534688] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 256.540357] sof-audio sof-audio: ipc: 0x60030000 succeeded user :err : [ 256.541101] Read PCM device error: Device or resource busy(-16) kern :debug : [ 256.547858] sof-audio sof-audio: pcm: close stream 0 dir 1 kern :debug : [ 256.647956] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 257.142935] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 257.344663] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 257.351722] sof-audio sof-audio: ipc: send 0x60040000 user :err : [ 257.357468] Write PCM device error: Input/output error(-5) kern :err : [ 257.357780] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 257.373037] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 257.637993] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 267.488478] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 267.495809] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 267.501507] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 267.509238] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 267.514937] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 267.521486] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 267.527700] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 267.534316] sof-audio sof-audio: pcm: close stream 0 dir 0 kern :debug : [ 267.537728] sof-audio sof-audio: ipc rx: 0x90020000 done user :notice: [ 267.545090] alsa-utils version 1.1.6 user :err : [ 267.545486] Exit playback thread fail: -5 user :notice: [ 267.563322] Entering playback thread (ALSA). user :notice: [ 267.573798] Get period size: 2112 buffer size: 16320 user :notice: [ 267.584315] Playing generated audio sine wave user :notice: [ 267.593886] Entering capture thread (ALSA). user :notice: [ 267.604156] Get period size: 2112 buffer size: 16320 user :notice: [ 267.612940] Recording ... user :notice: [ 267.621343] Fail: dual channels playback test failed. user :notice: [ 267.633413] Check_volume_dual_channels_48000_dat_playback FAIL kern :debug : [ 271.189196] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 271.195018] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 271.201760] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 271.207485] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 271.214175] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 271.220711] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 271.227359] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 271.233346] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 271.247766] get_mixer_properties PASS kern :debug : [ 271.497683] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 275.222970] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 275.228697] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 275.236346] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 275.242057] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 275.248593] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 275.254300] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 275.261269] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 275.267241] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 275.308014] set_HP_volume_to_minimum PASS kern :debug : [ 275.457644] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 277.542306] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 277.548383] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 277.556337] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 277.562607] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 277.569255] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 277.574968] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 277.582124] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 277.588457] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 277.631389] set_HP_volume_to_maximum PASS kern :debug : [ 277.932578] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 279.894155] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 279.900307] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 279.906847] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 279.912338] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 279.912643] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 279.925070] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 279.931027] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 279.937570] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 279.943696] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 279.985934] set_ADC_volume_to_minimum PASS kern :debug : [ 280.407524] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 283.250994] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 283.257067] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 283.265346] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 283.271670] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 283.278510] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 283.284623] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 283.290876] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 283.296685] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 283.340542] set_ADC_volume_to_maximum PASS kern :debug : [ 283.377481] sof-audio sof-audio: ipc rx: 0x90020000 done user :notice: [ 285.699159] /usr/bin/wget -q --local-encoding=UTF-8 --retry-connrefused --waitretry 1000 --tries 1000 http://inn:80/~lkp/cgi-bin/lkp-jobfile-append-var?job_file=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181018-18-hrreh0-0.yaml&job_state=post_run -O /dev/null user :notice: [ 294.374756] kill 981 vmstat --timestamp -n 10