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-20181017-18-1ostgqk-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/644120ad02935dff56ae9db7268b97594eab2e56/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=0x775e8c98 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 -13510558362501168. 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-20181017-18-1ostgqk-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/644120ad02935dff56ae9db7268b97594eab2e56/7f47792cbd22886d5fe2acbd229a13a6ea138e66/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout= 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.028020] 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.036905] Security Framework initialized kern :info : [ 0.040019] Yama: becoming mindful. kern :info : [ 0.044106] AppArmor: AppArmor initialized kern :info : [ 0.049783] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) kern :info : [ 0.052868] 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.065163] CPU: Physical Processor ID: 0 kern :info : [ 0.068018] CPU: Processor Core ID: 0 kern :info : [ 0.072049] mce: CPU supports 6 MCE banks kern :info : [ 0.076034] process: using mwait in idle threads kern :info : [ 0.080023] 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.092835] Freeing SMP alternatives memory: 36K kern :debug : [ 0.105995] 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.112052] ... version: 3 kern :info : [ 0.116018] ... bit width: 40 kern :info : [ 0.120015] ... generic registers: 2 kern :info : [ 0.124015] ... value mask: 000000ffffffffff kern :info : [ 0.128015] ... max period: 0000007fffffffff kern :info : [ 0.132013] ... 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.152121] smp: Bringing up secondary CPUs ... kern :info : [ 0.157031] x86: Booting SMP configuration: kern :info : [ 0.160038] .... node #0, CPUs: #1 kern :warn : [ 0.004000] masked ExtINT on CPU#1 kern :warn : [ 0.168873] #2 kern :warn : [ 0.004000] masked ExtINT on CPU#2 kern :warn : [ 0.176714] #3 kern :warn : [ 0.004000] masked ExtINT on CPU#3 kern :info : [ 0.182640] smp: Brought up 1 node, 4 CPUs kern :info : [ 0.184022] smpboot: Max logical packages: 1 kern :info : [ 0.188021] smpboot: Total of 4 processors activated (15327.20 BogoMIPS) kern :info : [ 0.194137] devtmpfs: initialized kern :info : [ 0.196000] x86/mm: Memory block size: 128MB kern :info : [ 0.203110] evm: security.selinux kern :info : [ 0.208021] evm: security.SMACK64 kern :info : [ 0.211738] evm: security.SMACK64EXEC kern :info : [ 0.216016] evm: security.SMACK64TRANSMUTE kern :info : [ 0.220014] evm: security.SMACK64MMAP kern :info : [ 0.224013] evm: security.apparmor kern :info : [ 0.227825] evm: security.ima kern :info : [ 0.232013] evm: security.capability kern :info : [ 0.237262] PM: Registering ACPI NVS region [mem 0x0008f000-0x0008ffff] (4096 bytes) kern :info : [ 0.248033] PM: Registering ACPI NVS region [mem 0x78fc0000-0x790bffff] (1048576 bytes) kern :info : [ 0.256453] 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.280610] RTC time: 9:53:48, date: 09/22/17 kern :info : [ 0.284559] NET: Registered protocol family 16 kern :info : [ 0.294516] cpuidle: using governor ladder kern :info : [ 0.296095] cpuidle: using governor menu kern :info : [ 0.301231] ACPI: bus type PCI registered kern :info : [ 0.304022] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 kern :info : [ 0.312426] 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.344321] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages kern :info : [ 0.356679] ACPI: Added _OSI(Module Device) kern :info : [ 0.360066] ACPI: Added _OSI(Processor Device) kern :info : [ 0.364019] ACPI: Added _OSI(3.0 _SCP Extensions) kern :info : [ 0.368016] ACPI: Added _OSI(Processor Aggregator Device) kern :info : [ 0.376020] ACPI: Added _OSI(Linux-Dell-Video) kern :info : [ 0.415754] ACPI: 6 ACPI AML tables successfully acquired and loaded kern :info : [ 0.443663] ACPI: Dynamic OEM Table Load: kern :info : [ 0.448048] ACPI: SSDT 0xFFFF8C182B36B400 0003B3 (v01 PmRef Cpu0Ist 00003000 INTL 20160527) kern :info : [ 0.458002] ACPI: Dynamic OEM Table Load: kern :info : [ 0.464042] ACPI: SSDT 0xFFFF8C182B36B800 000258 (v01 PmRef Cpu0Cst 00003001 INTL 20160527) kern :info : [ 0.474924] ACPI: Dynamic OEM Table Load: kern :info : [ 0.480044] ACPI: SSDT 0xFFFF8C182B394800 0001E0 (v01 PmRef ApIst 00003000 INTL 20160527) kern :info : [ 0.493433] ACPI: Dynamic OEM Table Load: kern :info : [ 0.496039] ACPI: SSDT 0xFFFF8C182B383500 0000C9 (v01 PmRef ApCst 00003000 INTL 20160527) kern :info : [ 0.515747] ACPI: Interpreter enabled kern :info : [ 0.520160] ACPI: (supports S0 S1 S3 S4 S5) kern :info : [ 0.524020] ACPI: Using IOAPIC for interrupt routing kern :info : [ 0.528226] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xe0000000-0xe3ffffff] (base 0xe0000000) kern :info : [ 0.542500] PCI: MMCONFIG at [mem 0xe0000000-0xe3ffffff] reserved in ACPI motherboard resources kern :info : [ 0.552075] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug kern :info : [ 0.561991] ACPI: Enabled 4 GPEs in block 00 to 3F kern :info : [ 0.602459] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.609698] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.617289] ACPI: Power Resource [USBC] (on) kern :info : [ 0.631909] (null): Device [PWM1] is in always present list kern :info : [ 0.648876] ACPI: Power Resource [CLK0] (on) kern :info : [ 0.652325] ACPI: Power Resource [CLK1] (on) kern :info : [ 0.661038] ACPI: Power Resource [PLPE] (on) kern :info : [ 0.672114] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) kern :info : [ 0.680045] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI] kern :info : [ 0.689324] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug] kern :info : [ 0.697336] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] kern :info : [ 0.708090] acpi PNP0A08:00: [Firmware Info]: MMCONFIG for domain 0000 [bus 00-3f] only partially covers this bridge kern :info : [ 0.718243] PCI host bridge to bus 0000:00 kern :info : [ 0.724032] pci_bus 0000:00: root bus resource [io 0x0070-0x0077] kern :info : [ 0.732041] pci_bus 0000:00: root bus resource [io 0x0000-0x006f window] kern :info : [ 0.740027] pci_bus 0000:00: root bus resource [io 0x0078-0x0cf7 window] kern :info : [ 0.748024] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] kern :info : [ 0.756024] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] kern :info : [ 0.764023] pci_bus 0000:00: root bus resource [mem 0x000c0000-0x000dffff window] kern :info : [ 0.772023] pci_bus 0000:00: root bus resource [mem 0x000e0000-0x000fffff window] kern :info : [ 0.780024] pci_bus 0000:00: root bus resource [mem 0x91000000-0x913fffff window] kern :info : [ 0.788022] pci_bus 0000:00: root bus resource [mem 0x80000000-0x909ffffe window] kern :info : [ 0.796023] pci_bus 0000:00: root bus resource [bus 00-ff] kern :debug : [ 0.804052] pci 0000:00:00.0: [8086:0f00] type 00 class 0x060000 kern :debug : [ 0.808604] pci 0000:00:02.0: [8086:0f31] type 00 class 0x030000 kern :debug : [ 0.816063] pci 0000:00:02.0: reg 0x10: [mem 0x90000000-0x903fffff] kern :debug : [ 0.824046] pci 0000:00:02.0: reg 0x18: [mem 0x80000000-0x8fffffff pref] kern :debug : [ 0.832044] pci 0000:00:02.0: reg 0x20: [io 0x2050-0x2057] kern :debug : [ 0.836615] pci 0000:00:14.0: [8086:0f35] type 00 class 0x0c0330 kern :debug : [ 0.844071] pci 0000:00:14.0: reg 0x10: [mem 0x90900000-0x9090ffff 64bit] kern :debug : [ 0.852157] pci 0000:00:14.0: PME# supported from D3hot D3cold kern :debug : [ 0.860548] pci 0000:00:1a.0: [8086:0f18] type 00 class 0x108000 kern :debug : [ 0.868071] pci 0000:00:1a.0: reg 0x10: [mem 0x90800000-0x908fffff] kern :debug : [ 0.872040] pci 0000:00:1a.0: reg 0x14: [mem 0x90700000-0x907fffff] kern :debug : [ 0.880177] pci 0000:00:1a.0: PME# supported from D0 D3hot kern :debug : [ 0.888522] pci 0000:00:1b.0: [8086:0f04] type 00 class 0x040300 kern :debug : [ 0.896076] pci 0000:00:1b.0: reg 0x10: [mem 0x90910000-0x90913fff 64bit] kern :debug : [ 0.900168] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold kern :debug : [ 0.908521] pci 0000:00:1c.0: [8086:0f48] type 01 class 0x060400 kern :debug : [ 0.916184] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold kern :debug : [ 0.924551] pci 0000:00:1c.1: [8086:0f4a] type 01 class 0x060400 kern :debug : [ 0.932183] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold kern :debug : [ 0.936549] pci 0000:00:1c.2: [8086:0f4c] type 01 class 0x060400 kern :debug : [ 0.944182] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold kern :debug : [ 0.952563] pci 0000:00:1c.3: [8086:0f4e] type 01 class 0x060400 kern :debug : [ 0.960183] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold kern :debug : [ 0.964557] pci 0000:00:1f.0: [8086:0f1c] type 00 class 0x060100 kern :debug : [ 0.972649] pci 0000:00:1f.3: [8086:0f12] type 00 class 0x0c0500 kern :debug : [ 0.980089] pci 0000:00:1f.3: reg 0x10: [mem 0x9091c000-0x9091c01f] kern :debug : [ 0.988128] pci 0000:00:1f.3: reg 0x20: [io 0x2000-0x201f] kern :info : [ 0.996858] pci 0000:00:1c.0: PCI bridge to [bus 01] kern :debug : [ 1.000031] pci 0000:00:1c.0: bridge window [io 0x3000-0x3fff] kern :info : [ 1.008285] pci 0000:00:1c.1: PCI bridge to [bus 02] kern :debug : [ 1.012031] pci 0000:00:1c.1: bridge window [io 0x4000-0x4fff] kern :debug : [ 1.020339] pci 0000:03:00.0: [8086:1533] type 00 class 0x020000 kern :debug : [ 1.028104] pci 0000:03:00.0: reg 0x10: [mem 0x90600000-0x9067ffff] kern :debug : [ 1.036071] pci 0000:03:00.0: reg 0x18: [io 0x1000-0x101f] kern :debug : [ 1.040052] pci 0000:03:00.0: reg 0x1c: [mem 0x90680000-0x90683fff] kern :debug : [ 1.048263] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold kern :info : [ 1.056448] pci 0000:00:1c.2: PCI bridge to [bus 03] kern :debug : [ 1.060031] pci 0000:00:1c.2: bridge window [io 0x1000-0x1fff] kern :debug : [ 1.068027] pci 0000:00:1c.2: bridge window [mem 0x90600000-0x906fffff] kern :debug : [ 1.076030] pci 0000:00:1c.2: bridge window [mem 0x90400000-0x905fffff 64bit pref] kern :info : [ 1.084274] pci 0000:00:1c.3: PCI bridge to [bus 04] kern :debug : [ 1.088031] pci 0000:00:1c.3: bridge window [io 0x5000-0x5fff] kern :debug : [ 1.096027] pci 0000:00:1c.3: bridge window [mem 0x91000000-0x911fffff] kern :debug : [ 1.104030] pci 0000:00:1c.3: bridge window [mem 0x91200000-0x913fffff 64bit pref] kern :info : [ 1.114499] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.124523] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.132503] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.144501] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.152502] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.164501] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.172500] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :info : [ 1.180506] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled. kern :debug : [ 1.193644] IOAPIC[0]: Set routing entry (2-49 -> 0xef -> IRQ 49 Mode:1 Active:1 Dest:1) kern :debug : [ 1.204994] IOAPIC[0]: Set routing entry (2-48 -> 0xef -> IRQ 48 Mode:1 Active:1 Dest:1) kern :debug : [ 1.212757] IOAPIC[0]: Set routing entry (2-50 -> 0xef -> IRQ 50 Mode:1 Active:1 Dest:1) kern :debug : [ 1.226069] IOAPIC[0]: Set routing entry (2-44 -> 0xef -> IRQ 44 Mode:1 Active:1 Dest:1) kern :debug : [ 1.236847] IOAPIC[0]: Set routing entry (2-46 -> 0xef -> IRQ 46 Mode:1 Active:1 Dest:1) kern :debug : [ 1.244803] IOAPIC[0]: Set routing entry (2-47 -> 0xef -> IRQ 47 Mode:1 Active:1 Dest:1) kern :debug : [ 1.253020] IOAPIC[0]: Set routing entry (2-42 -> 0xef -> IRQ 42 Mode:1 Active:1 Dest:1) kern :debug : [ 1.265010] IOAPIC[0]: Set routing entry (2-43 -> 0xef -> IRQ 43 Mode:1 Active:1 Dest:1) kern :debug : [ 1.274850] IOAPIC[0]: Set routing entry (2-39 -> 0xef -> IRQ 39 Mode:1 Active:1 Dest:1) kern :debug : [ 1.285242] IOAPIC[0]: Set routing entry (2-40 -> 0xef -> IRQ 40 Mode:1 Active:1 Dest:1) kern :debug : [ 1.297251] IOAPIC[0]: Set routing entry (2-41 -> 0xef -> IRQ 41 Mode:1 Active:1 Dest:1) kern :debug : [ 1.310285] IOAPIC[0]: Set routing entry (2-37 -> 0xef -> IRQ 37 Mode:1 Active:1 Dest:1) kern :debug : [ 1.317793] IOAPIC[0]: Set routing entry (2-38 -> 0xef -> IRQ 38 Mode:1 Active:1 Dest:1) kern :debug : [ 1.329263] IOAPIC[0]: Set routing entry (2-24 -> 0xef -> IRQ 24 Mode:1 Active:1 Dest:1) kern :debug : [ 1.340091] IOAPIC[0]: Set routing entry (2-25 -> 0xef -> IRQ 25 Mode:1 Active:1 Dest:1) kern :debug : [ 1.348086] IOAPIC[0]: Set routing entry (2-26 -> 0xef -> IRQ 26 Mode:1 Active:1 Dest:1) kern :debug : [ 1.356098] IOAPIC[0]: Set routing entry (2-27 -> 0xef -> IRQ 27 Mode:1 Active:1 Dest:1) kern :debug : [ 1.368098] IOAPIC[0]: Set routing entry (2-28 -> 0xef -> IRQ 28 Mode:1 Active:1 Dest:1) kern :debug : [ 1.376089] IOAPIC[0]: Set routing entry (2-29 -> 0xef -> IRQ 29 Mode:1 Active:1 Dest:1) kern :info : [ 1.424894] dw_dmac INTL9C60:00: DesignWare DMA Controller, 8 channels kern :info : [ 1.472920] dw_dmac INTL9C60:01: DesignWare DMA Controller, 8 channels kern :info : [ 1.480877] pci 0000:00:02.0: vgaarb: setting as boot VGA device kern :info : [ 1.484000] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none kern :info : [ 1.500041] pci 0000:00:02.0: vgaarb: bridge control possible kern :info : [ 1.504017] vgaarb: loaded kern :notice: [ 1.508363] SCSI subsystem initialized kern :debug : [ 1.512104] libata version 3.00 loaded. kern :info : [ 1.516159] ACPI: bus type USB registered kern :info : [ 1.524140] usbcore: registered new interface driver usbfs kern :info : [ 1.528081] usbcore: registered new interface driver hub kern :info : [ 1.536150] usbcore: registered new device driver usb kern :info : [ 1.617648] pps_core: LinuxPPS API ver. 1 registered kern :info : [ 1.624021] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti kern :info : [ 1.636047] PTP clock support registered kern :info : [ 1.640155] EDAC MC: Ver: 3.0.0 kern :info : [ 1.644225] Registered efivars operations kern :info : [ 1.660983] PCI: Using ACPI for IRQ routing kern :debug : [ 1.666689] PCI: pci_cache_line_size set to 64 bytes kern :debug : [ 1.672138] e820: reserve RAM buffer [mem 0x0008f000-0x0008ffff] kern :debug : [ 1.680021] e820: reserve RAM buffer [mem 0x0009e000-0x0009ffff] kern :debug : [ 1.684020] e820: reserve RAM buffer [mem 0x786c0000-0x7bffffff] kern :debug : [ 1.692021] e820: reserve RAM buffer [mem 0x7a000000-0x7bffffff] kern :info : [ 1.700640] NetLabel: Initializing kern :info : [ 1.704020] NetLabel: domain hash size = 128 kern :info : [ 1.708014] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO kern :info : [ 1.716120] NetLabel: unlabeled traffic allowed by default kern :info : [ 1.724020] clocksource: Switched to clocksource tsc-early kern :notice: [ 1.816696] VFS: Disk quotas dquot_6.6.0 kern :info : [ 1.821224] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) kern :info : [ 1.829667] AppArmor: AppArmor Filesystem Enabled kern :info : [ 1.835143] pnp: PnP ACPI init kern :debug : [ 1.839051] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) kern :info : [ 1.846803] system 00:01: [io 0x0680-0x069f] has been reserved kern :info : [ 1.853477] system 00:01: [io 0x0400-0x047f] has been reserved kern :info : [ 1.860141] system 00:01: [io 0x0500-0x05fe] has been reserved kern :debug : [ 1.866829] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) kern :debug : [ 1.875089] pnp 00:02: Plug and Play ACPI device, IDs PNP0501 (active) kern :info : [ 1.884086] system 00:03: [mem 0xe0000000-0xefffffff] could not be reserved kern :info : [ 1.891927] system 00:03: [mem 0xfed01000-0xfed01fff] has been reserved kern :info : [ 1.899369] system 00:03: [mem 0xfed03000-0xfed03fff] has been reserved kern :info : [ 1.906827] system 00:03: [mem 0xfed04000-0xfed04fff] has been reserved kern :info : [ 1.914274] system 00:03: [mem 0xfed0c000-0xfed0ffff] could not be reserved kern :info : [ 1.922120] system 00:03: [mem 0xfed08000-0xfed08fff] has been reserved kern :info : [ 1.929565] system 00:03: [mem 0xfed1c000-0xfed1cfff] has been reserved kern :info : [ 1.937007] system 00:03: [mem 0xfee00000-0xfeefffff] has been reserved kern :info : [ 1.944448] system 00:03: [mem 0xfef00000-0xfeffffff] has been reserved kern :debug : [ 1.951912] system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active) kern :info : [ 1.965634] pnp: PnP ACPI: found 4 devices kern :info : [ 1.987293] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns kern :debug : [ 1.997314] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 01] add_size 200000 add_align 100000 kern :debug : [ 2.010213] pci 0000:00:1c.0: bridge window [mem 0x00100000-0x000fffff] to [bus 01] add_size 200000 add_align 100000 kern :debug : [ 2.022049] pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 kern :debug : [ 2.034941] pci 0000:00:1c.1: bridge window [mem 0x00100000-0x000fffff] to [bus 02] add_size 200000 add_align 100000 kern :info : [ 2.046808] pci 0000:00:1c.0: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.054359] pci 0000:00:1c.0: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.062315] pci 0000:00:1c.0: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.070924] pci 0000:00:1c.0: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.079931] pci 0000:00:1c.1: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.087464] pci 0000:00:1c.1: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.095414] pci 0000:00:1c.1: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.104021] pci 0000:00:1c.1: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.113031] pci 0000:00:1c.1: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.120565] pci 0000:00:1c.1: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.128513] pci 0000:00:1c.1: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.137119] pci 0000:00:1c.1: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.146124] pci 0000:00:1c.0: BAR 14: no space for [mem size 0x00200000] kern :info : [ 2.153657] pci 0000:00:1c.0: BAR 14: failed to assign [mem size 0x00200000] kern :info : [ 2.161611] pci 0000:00:1c.0: BAR 15: no space for [mem size 0x00200000 64bit pref] kern :info : [ 2.170218] pci 0000:00:1c.0: BAR 15: failed to assign [mem size 0x00200000 64bit pref] kern :info : [ 2.179223] pci 0000:00:1c.0: PCI bridge to [bus 01] kern :info : [ 2.184826] pci 0000:00:1c.0: bridge window [io 0x3000-0x3fff] kern :info : [ 2.191699] pci 0000:00:1c.1: PCI bridge to [bus 02] kern :info : [ 2.197290] pci 0000:00:1c.1: bridge window [io 0x4000-0x4fff] kern :info : [ 2.204161] pci 0000:00:1c.2: PCI bridge to [bus 03] kern :info : [ 2.209752] pci 0000:00:1c.2: bridge window [io 0x1000-0x1fff] kern :info : [ 2.216610] pci 0000:00:1c.2: bridge window [mem 0x90600000-0x906fffff] kern :info : [ 2.224243] pci 0000:00:1c.2: bridge window [mem 0x90400000-0x905fffff 64bit pref] kern :info : [ 2.232951] pci 0000:00:1c.3: PCI bridge to [bus 04] kern :info : [ 2.238540] pci 0000:00:1c.3: bridge window [io 0x5000-0x5fff] kern :info : [ 2.245398] pci 0000:00:1c.3: bridge window [mem 0x91000000-0x911fffff] kern :info : [ 2.253032] pci 0000:00:1c.3: bridge window [mem 0x91200000-0x913fffff 64bit pref] kern :debug : [ 2.261742] pci_bus 0000:00: resource 4 [io 0x0070-0x0077] kern :debug : [ 2.268022] pci_bus 0000:00: resource 5 [io 0x0000-0x006f window] kern :debug : [ 2.274971] pci_bus 0000:00: resource 6 [io 0x0078-0x0cf7 window] kern :debug : [ 2.281921] pci_bus 0000:00: resource 7 [io 0x0d00-0xffff window] kern :debug : [ 2.288869] pci_bus 0000:00: resource 8 [mem 0x000a0000-0x000bffff window] kern :debug : [ 2.296596] pci_bus 0000:00: resource 9 [mem 0x000c0000-0x000dffff window] kern :debug : [ 2.304321] pci_bus 0000:00: resource 10 [mem 0x000e0000-0x000fffff window] kern :debug : [ 2.312147] pci_bus 0000:00: resource 11 [mem 0x91000000-0x913fffff window] kern :debug : [ 2.319972] pci_bus 0000:00: resource 12 [mem 0x80000000-0x909ffffe window] kern :debug : [ 2.327798] pci_bus 0000:01: resource 0 [io 0x3000-0x3fff] kern :debug : [ 2.334068] pci_bus 0000:02: resource 0 [io 0x4000-0x4fff] kern :debug : [ 2.340337] pci_bus 0000:03: resource 0 [io 0x1000-0x1fff] kern :debug : [ 2.346604] pci_bus 0000:03: resource 1 [mem 0x90600000-0x906fffff] kern :debug : [ 2.353649] pci_bus 0000:03: resource 2 [mem 0x90400000-0x905fffff 64bit pref] kern :debug : [ 2.361766] pci_bus 0000:04: resource 0 [io 0x5000-0x5fff] kern :debug : [ 2.368034] pci_bus 0000:04: resource 1 [mem 0x91000000-0x911fffff] kern :debug : [ 2.375079] pci_bus 0000:04: resource 2 [mem 0x91200000-0x913fffff 64bit pref] kern :info : [ 2.383662] NET: Registered protocol family 2 kern :info : [ 2.389416] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes) kern :info : [ 2.398325] TCP established hash table entries: 16384 (order: 5, 131072 bytes) kern :info : [ 2.406700] TCP bind hash table entries: 16384 (order: 6, 262144 bytes) kern :info : [ 2.414438] TCP: Hash tables configured (established 16384 bind 16384) kern :info : [ 2.421950] UDP hash table entries: 1024 (order: 3, 32768 bytes) kern :info : [ 2.428786] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes) kern :info : [ 2.436325] NET: Registered protocol family 1 kern :info : [ 2.441328] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] kern :debug : [ 2.451258] IOAPIC[0]: Set routing entry (2-20 -> 0xef -> IRQ 20 Mode:1 Active:1 Dest:1) kern :debug : [ 2.460962] PCI: CLS 128 bytes, default 64 kern :info : [ 2.465854] Trying to unpack rootfs image as initramfs... kern :info : [ 19.735030] Freeing initrd memory: 140824K kern :info : [ 19.741209] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x373bb0d4809, max_idle_ns: 881590714052 ns kern :info : [ 19.752529] clocksource: Switched to clocksource tsc kern :info : [ 19.758314] Scanning for low memory corruption every 60 seconds kern :notice: [ 19.769260] Initialise system trusted keyrings kern :info : [ 19.774538] workingset: timestamp_bits=40 max_order=19 bucket_order=0 kern :info : [ 19.791610] zbud: loaded kern :info : [ 19.798857] fuse init (API version 7.26) kern :info : [ 19.803808] pstore: using deflate compression kern :notice: [ 19.812405] Key type asymmetric registered kern :notice: [ 19.817033] Asymmetric key parser 'x509' registered kern :info : [ 19.822766] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) kern :info : [ 19.831295] io scheduler noop registered kern :info : [ 19.835744] io scheduler deadline registered (default) kern :info : [ 19.841849] io scheduler cfq registered kern :info : [ 19.846191] io scheduler mq-deadline registered (default) kern :info : [ 19.852280] io scheduler kyber registered kern :debug : [ 19.857925] IOAPIC[0]: Set routing entry (2-16 -> 0xef -> IRQ 16 Mode:1 Active:1 Dest:1) kern :debug : [ 19.867890] IOAPIC[0]: Set routing entry (2-17 -> 0xef -> IRQ 17 Mode:1 Active:1 Dest:1) kern :debug : [ 19.877805] IOAPIC[0]: Set routing entry (2-18 -> 0xef -> IRQ 18 Mode:1 Active:1 Dest:1) kern :debug : [ 19.887718] IOAPIC[0]: Set routing entry (2-19 -> 0xef -> IRQ 19 Mode:1 Active:1 Dest:1) kern :info : [ 19.897329] pcieport 0000:00:1c.0: Signaling PME with IRQ 87 kern :info : [ 19.903821] pcieport 0000:00:1c.1: Signaling PME with IRQ 88 kern :info : [ 19.910319] pcieport 0000:00:1c.2: Signaling PME with IRQ 89 kern :info : [ 19.916805] pcieport 0000:00:1c.3: Signaling PME with IRQ 90 kern :debug : [ 19.923465] intel_idle: MWAIT substates: 0x3000020 kern :debug : [ 19.928871] intel_idle: v0.4.1 model 0x37 kern :debug : [ 19.934133] intel_idle: lapic_timer_reliable_states 0xffffffff kern :info : [ 19.941234] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 kern :info : [ 19.950709] ACPI: Power Button [PWRB] kern :info : [ 19.955121] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 kern :info : [ 19.964568] ACPI: Sleep Button [SLPB] kern :info : [ 19.968994] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 kern :info : [ 19.977377] ACPI: Power Button [PWRF] kern :info : [ 19.996842] thermal LNXTHERM:00: registered as thermal_zone0 kern :info : [ 20.003233] ACPI: Thermal Zone [TZ01] (32 C) kern :info : [ 20.009124] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled kern :info : [ 20.036625] 00:02: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A kern :warn : [ 20.056566] hpet: number irqs doesn't agree with number of timers kern :info : [ 20.063845] Linux agpgart interface v0.103 kern :info : [ 20.089440] brd: module loaded kern :info : [ 20.105553] loop: module loaded kern :info : [ 20.112709] libphy: Fixed MDIO Bus: probed kern :info : [ 20.117346] tun: Universal TUN/TAP device driver, 1.6 kern :info : [ 20.123886] PPP generic driver version 2.4.2 kern :info : [ 20.129520] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver kern :info : [ 20.136908] ehci-pci: EHCI PCI platform driver kern :info : [ 20.141988] ehci-platform: EHCI generic platform driver kern :info : [ 20.147953] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver kern :info : [ 20.154976] ohci-pci: OHCI PCI platform driver kern :info : [ 20.160083] ohci-platform: OHCI generic platform driver kern :info : [ 20.166031] uhci_hcd: USB Universal Host Controller Interface driver kern :debug : [ 20.173896] IOAPIC[0]: Set routing entry (2-20 -> 0xef -> IRQ 20 Mode:1 Active:1 Dest:1) kern :info : [ 20.183085] xhci_hcd 0000:00:14.0: xHCI Host Controller kern :info : [ 20.189009] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 1 kern :info : [ 20.198508] xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x00009810 kern :debug : [ 20.208026] xhci_hcd 0000:00:14.0: cache line size of 128 is not supported kern :info : [ 20.216399] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.17 kern :info : [ 20.225704] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 kern :info : [ 20.233833] usb usb1: Product: xHCI Host Controller kern :info : [ 20.239331] usb usb1: Manufacturer: Linux 4.17.0+ xhci-hcd kern :info : [ 20.245508] usb usb1: SerialNumber: 0000:00:14.0 kern :info : [ 20.251650] hub 1-0:1.0: USB hub found kern :info : [ 20.255953] hub 1-0:1.0: 6 ports detected kern :info : [ 20.263214] xhci_hcd 0000:00:14.0: xHCI Host Controller kern :info : [ 20.269129] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2 kern :info : [ 20.277476] xhci_hcd 0000:00:14.0: Host supports USB 3.0 SuperSpeed kern :info : [ 20.284897] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003, bcdDevice= 4.17 kern :info : [ 20.294212] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 kern :info : [ 20.302344] usb usb2: Product: xHCI Host Controller kern :info : [ 20.307843] usb usb2: Manufacturer: Linux 4.17.0+ xhci-hcd kern :info : [ 20.314021] usb usb2: SerialNumber: 0000:00:14.0 kern :info : [ 20.320209] hub 2-0:1.0: USB hub found kern :info : [ 20.324500] hub 2-0:1.0: 1 port detected kern :info : [ 20.329936] i8042: PNP: No PS/2 controller found. kern :info : [ 20.335247] i8042: Probing ports directly. kern :info : [ 21.375678] i8042: No controller found kern :info : [ 21.381578] mousedev: PS/2 mouse device common for all mice kern :info : [ 21.390013] rtc_cmos 00:00: RTC can wake from S4 kern :info : [ 21.395994] rtc_cmos 00:00: registered as rtc0 kern :info : [ 21.401149] rtc_cmos 00:00: alarms up to one month, y3k, 242 bytes nvram kern :info : [ 21.408750] i2c /dev entries driver kern :info : [ 21.413972] device-mapper: uevent: version 1.0.3 kern :info : [ 21.419751] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com kern :info : [ 21.429265] intel_pstate: Intel P-state driver initializing kern :info : [ 21.437474] ledtrig-cpu: registered to indicate activity on CPUs kern :info : [ 21.444199] EFI Variables Facility v0.08 2004-May-17 kern :info : [ 21.467385] NET: Registered protocol family 10 kern :info : [ 21.473506] Segment Routing with IPv6 kern :info : [ 21.477643] NET: Registered protocol family 17 kern :notice: [ 21.482631] Key type dns_resolver registered kern :info : [ 21.489416] microcode: sig=0x30679, pf=0x1, revision=0x906 kern :info : [ 21.496472] microcode: Microcode Update Driver: v2.2. kern :info : [ 21.496573] ... APIC ID: 00000000 (0) kern :info : [ 21.500569] ... APIC VERSION: 00050014 kern :warn : [ 21.500569] 0000000000000000000000000000000000000000000000000000000000000000 kern :warn : [ 21.500569] 0000000002000004000000000002000000020002000000000000000000000000 kern :warn : [ 21.520403] 0000000000000000000000000000000000000000000000000000000000001000 kern :debug : [ 21.534630] number of MP IRQ sources: 15. kern :debug : [ 21.539117] number of IO-APIC #2 registers: 87. kern :info : [ 21.544185] testing the IO APIC....................... kern :debug : [ 21.549938] IO APIC #2...... kern :debug : [ 21.553158] .... register #00: 01000000 kern :debug : [ 21.557447] ....... : physical APIC id: 01 kern :debug : [ 21.562318] ....... : Delivery Type: 0 kern :debug : [ 21.566801] ....... : LTS : 0 kern :debug : [ 21.571285] .... register #01: 00560020 kern :debug : [ 21.575575] ....... : max redirection entries: 56 kern :debug : [ 21.581224] ....... : PRQ implemented: 0 kern :debug : [ 21.585998] ....... : IO APIC version: 20 kern :debug : [ 21.590871] .... IRQ redirection table: kern :debug : [ 21.595159] IOAPIC 0: kern :debug : [ 21.597705] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.606471] pin01, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.615239] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 21.624008] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.632772] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.641536] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.650301] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.659065] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.667830] pin08, enabled , level, high, V(24), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 21.676596] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(02), M(0) kern :debug : [ 21.685360] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.694126] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.702891] pin0c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.711656] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.720420] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.729184] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.737947] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.746713] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.755476] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.764242] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.773008] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.781772] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.790537] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.799303] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.808067] pin18, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.816831] pin19, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.825599] pin1a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.834366] pin1b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.843133] pin1c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.851899] pin1d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.860664] pin1e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.869432] pin1f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.878199] pin20, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.886966] pin21, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.895732] pin22, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.904497] pin23, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.913262] pin24, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.922028] pin25, enabled , level, low , V(22), IRR(0), S(0), logical , D(08), M(0) kern :debug : [ 21.930792] pin26, enabled , level, low , V(22), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 21.939557] pin27, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.948322] pin28, disabled, edge , high, V(F6), IRR(0), S(0), logical , D(CB), M(2) kern :debug : [ 21.957088] pin29, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.965854] pin2a, enabled , level, low , V(22), IRR(0), S(0), logical , D(02), M(0) kern :debug : [ 21.974621] pin2b, enabled , level, low , V(22), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 21.983387] pin2c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 21.992154] pin2d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.000921] pin2e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.009688] pin2f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.018453] pin30, enabled , level, low , V(21), IRR(0), S(0), logical , D(08), M(0) kern :debug : [ 22.027218] pin31, enabled , level, low , V(21), IRR(0), S(0), logical , D(04), M(0) kern :debug : [ 22.035982] pin32, enabled , level, low , V(21), IRR(0), S(0), logical , D(01), M(0) kern :debug : [ 22.044747] pin33, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.053515] pin34, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.062281] pin35, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.071048] pin36, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.079813] pin37, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.088579] pin38, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.097343] pin39, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.106109] pin3a, disabled, edge , high, V(7D), IRR(0), S(0), logical , D(FF), M(2) kern :debug : [ 22.114875] pin3b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.123639] pin3c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.132405] pin3d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.141174] pin3e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.149940] pin3f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.158707] pin40, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.167474] pin41, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.176239] pin42, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.185003] pin43, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.193769] pin44, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.202533] pin45, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.211300] pin46, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.220065] pin47, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.228832] pin48, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.237597] pin49, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.246362] pin4a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.255127] pin4b, disabled, edge , high, V(7C), IRR(0), S(0), logical , D(B3), M(2) kern :debug : [ 22.263894] pin4c, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.272662] pin4d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.281427] pin4e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.290191] pin4f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.298957] pin50, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.307721] pin51, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.316488] pin52, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.325253] pin53, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.334018] pin54, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.342783] pin55, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.351548] pin56, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) kern :debug : [ 22.360310] IRQ to pin mappings: kern :debug : [ 22.363915] IRQ0 -> 0:2 kern :debug : [ 22.366653] IRQ1 -> 0:1 kern :debug : [ 22.369390] IRQ3 -> 0:3 kern :debug : [ 22.372127] IRQ4 -> 0:4 kern :debug : [ 22.374857] IRQ5 -> 0:5 kern :debug : [ 22.377593] IRQ6 -> 0:6 kern :debug : [ 22.380321] IRQ7 -> 0:7 kern :debug : [ 22.383052] IRQ8 -> 0:8 kern :debug : [ 22.385788] IRQ9 -> 0:9 kern :debug : [ 22.388525] IRQ10 -> 0:10 kern :debug : [ 22.391450] IRQ11 -> 0:11 kern :debug : [ 22.394380] IRQ12 -> 0:12 kern :debug : [ 22.397311] IRQ13 -> 0:13 kern :debug : [ 22.400245] IRQ14 -> 0:14 kern :debug : [ 22.403170] IRQ15 -> 0:15 kern :debug : [ 22.406101] IRQ16 -> 0:16 kern :debug : [ 22.409032] IRQ17 -> 0:17 kern :debug : [ 22.411957] IRQ18 -> 0:18 kern :debug : [ 22.414887] IRQ19 -> 0:19 kern :debug : [ 22.417818] IRQ20 -> 0:20 kern :debug : [ 22.420750] IRQ24 -> 0:24 kern :debug : [ 22.423674] IRQ25 -> 0:25 kern :debug : [ 22.426605] IRQ26 -> 0:26 kern :debug : [ 22.429536] IRQ27 -> 0:27 kern :debug : [ 22.432468] IRQ28 -> 0:28 kern :debug : [ 22.435393] IRQ29 -> 0:29 kern :debug : [ 22.438324] IRQ37 -> 0:37 kern :debug : [ 22.441255] IRQ38 -> 0:38 kern :debug : [ 22.444186] IRQ39 -> 0:39 kern :debug : [ 22.447111] IRQ40 -> 0:40 kern :debug : [ 22.450041] IRQ41 -> 0:41 kern :debug : [ 22.452973] IRQ42 -> 0:42 kern :debug : [ 22.455897] IRQ43 -> 0:43 kern :debug : [ 22.458828] IRQ44 -> 0:44 kern :debug : [ 22.461759] IRQ46 -> 0:46 kern :debug : [ 22.464690] IRQ47 -> 0:47 kern :debug : [ 22.467614] IRQ48 -> 0:48 kern :debug : [ 22.470545] IRQ49 -> 0:49 kern :debug : [ 22.473475] IRQ50 -> 0:50 kern :info : [ 22.476399] .................................... done. kern :info : [ 22.482234] sched_clock: Marking stable (22482209772, 0)->(22563017119, -80807347) kern :info : [ 22.495857] registered taskstats version 1 kern :notice: [ 22.500451] Loading compiled-in X.509 certificates kern :notice: [ 22.514979] Loaded X.509 cert 'Build time autogenerated kernel key: 34d4ca7bc7e4c62ceb42b3558cd8900bf870ea7b' kern :info : [ 22.526139] zswap: loaded using pool lzo/zbud kern :notice: [ 22.535734] Key type trusted registered kern :notice: [ 22.547069] Key type encrypted registered kern :info : [ 22.551572] AppArmor: AppArmor sha1 policy hashing enabled kern :info : [ 22.557714] ima: No TPM chip found, activating TPM-bypass! (rc=-19) kern :info : [ 22.564735] ima: Allocated hash algorithm: sha1 kern :info : [ 22.569834] evm: HMAC attrs: 0x1 kern :info : [ 22.574232] Magic number: 1:963:879 kern :info : [ 22.578861] rtc_cmos 00:00: setting system clock to 2017-09-22 09:54:11 UTC (1506074051) kern :info : [ 22.609891] Freeing unused kernel memory: 1712K kern :info : [ 22.628444] Write protecting the kernel read-only data: 18432k kern :info : [ 22.637208] Freeing unused kernel memory: 2008K kern :info : [ 22.643975] Freeing unused kernel memory: 104K daemon:info : [ 22.688155] systemd-udevd[116]: starting version 208 kern :notice: [ 22.694560] random: systemd-udevd: uninitialized urandom read (4 bytes read) kern :info : [ 22.729412] sdhci: Secure Digital Host Controller Interface driver kern :info : [ 22.736361] sdhci: Copyright(c) Pierre Ossman kern :info : [ 22.741506] 80860F0A:00: ttyS4 at MMIO 0x90c15000 (irq = 39, base_baud = 6250000) is a 16550A kern :debug : [ 22.752276] evbug: Connected device: input0 (Power Button at PNP0C0C/button/input0) kern :debug : [ 22.761521] evbug: Connected device: input1 (Sleep Button at PNP0C0E/button/input0) kern :debug : [ 22.770710] evbug: Connected device: input2 (Power Button at LNXPWRBN/button/input0) kern :debug : [ 22.803757] IOAPIC[0]: Set routing entry (2-21 -> 0xef -> IRQ 21 Mode:1 Active:1 Dest:1) kern :info : [ 22.812935] 80860F0A:01: ttyS5 at MMIO 0x90c17000 (irq = 40, base_baud = 6250000) is a 16550A kern :info : [ 22.841461] dca service started, version 1.12.1 kern :info : [ 22.868611] mmc0: SDHCI controller on ACPI [80860F14:01] using ADMA kern :info : [ 22.877726] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt kern :info : [ 22.879890] mmc1: SDHCI controller on ACPI [INT33BB:00] using ADMA kern :warn : [ 22.892477] sdhci-acpi 80860F16:00: failed to setup card detect gpio kern :info : [ 22.900158] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k kern :info : [ 22.900742] mmc2: SDHCI controller on ACPI [80860F16:00] using ADMA kern :info : [ 22.907977] igb: Copyright (c) 2007-2014 Intel Corporation. kern :info : [ 22.921766] input: PC Speaker as /devices/platform/pcspkr/input/input3 kern :debug : [ 22.930067] evbug: Connected device: input3 (PC Speaker at isa0061/input0) kern :info : [ 22.952655] cryptd: max_cpu_qlen set to 1000 kern :debug : [ 22.971117] sof-audio-acpi 80860F28:01: ACPI DSP detected kern :info : [ 22.977840] sof-audio-acpi 80860F28:01: BYT-CR not detected kern :info : [ 22.984352] SSE version of gcm_enc/dec engaged. kern :debug : [ 22.986731] sof-audio-acpi 80860F28:01: created machine bytcr_rt5651 kern :info : [ 22.996595] sof-audio-acpi 80860F28:01: info: loading firmware intel/sof-byt.ri kern :debug : [ 23.005141] sof-audio sof-audio: probing SOF DSP device.... kern :debug : [ 23.011447] sof-audio sof-audio: using platform alias sst-mfld-platform kern :debug : [ 23.018880] sof-audio sof-audio: LPE PHY base at 0x90a00000 size 0x200000 kern :debug : [ 23.026517] sof-audio sof-audio: LPE VADDR (ptrval) kern :debug : [ 23.032773] sof-audio sof-audio: IMR base at 0x20000000 size 0x100000 kern :debug : [ 23.040031] sof-audio sof-audio: IMR VADDR (ptrval) kern :debug : [ 23.046271] sof-audio sof-audio: using IRQ 29 kern :info : [ 23.046314] mmc2: new high speed SDHC card at address aaaa kern :debug : [ 23.056199] sof-audio sof-audio: pre-allocate 8 IPC messages kern :debug : [ 23.063655] sof-audio sof-audio: loading firmware kern :debug : [ 23.068953] sof-audio sof-audio: header size=0x11a45 modules=0x1 abi=0x1 size=16 kern :debug : [ 23.077287] sof-audio sof-audio: new module size 0x11a39 blocks 0xe type 0x0 kern :debug : [ 23.085193] sof-audio sof-audio: block 0 type 0x1 size 0x160 ==> offset 0xc0000 kern :debug : [ 23.093527] sof-audio sof-audio: block 1 type 0x1 size 0x16a ==> offset 0xc0400 kern :debug : [ 23.101850] sof-audio sof-audio: block 2 type 0x1 size 0x6 ==> offset 0xc057c kern :debug : [ 23.109934] sof-audio sof-audio: block 3 type 0x1 size 0x6 ==> offset 0xc059c kern :debug : [ 23.118019] sof-audio sof-audio: block 4 type 0x1 size 0x6 ==> offset 0xc05bc kern :debug : [ 23.126103] sof-audio sof-audio: block 5 type 0x1 size 0x6 ==> offset 0xc05dc kern :debug : [ 23.134186] sof-audio sof-audio: block 6 type 0x1 size 0x3 ==> offset 0xc061c kern :debug : [ 23.142270] sof-audio sof-audio: block 7 type 0x1 size 0x6 ==> offset 0xc063c kern :debug : [ 23.150355] sof-audio sof-audio: block 8 type 0x1 size 0x4 ==> offset 0xc0658 kern :debug : [ 23.158439] sof-audio sof-audio: block 9 type 0x1 size 0x17 ==> offset 0xc065c kern :debug : [ 23.166628] sof-audio sof-audio: block 10 type 0x1 size 0x6 ==> offset 0xc067c kern :debug : [ 23.174812] sof-audio sof-audio: block 11 type 0x1 size 0xed9d ==> offset 0xc06a0 kern :info : [ 23.175673] mmcblk2: mmc2:aaaa SL32G 29.7 GiB kern :info : [ 23.189849] iTCO_vendor_support: vendor-support=0 kern :debug : [ 23.191206] sof-audio sof-audio: block 12 type 0x2 size 0x1d10 ==> offset 0x100008 kern :info : [ 23.195413] pps pps0: new PPS source ptp0 kern :debug : [ 23.204678] sof-audio sof-audio: block 13 type 0x2 size 0xbd8 ==> offset 0x101d18 kern :info : [ 23.208263] igb 0000:03:00.0: added PHC on eth0 kern :debug : [ 23.217089] sof-audio sof-audio: booting DSP firmware kern :info : [ 23.221797] igb 0000:03:00.0: Intel(R) Gigabit Ethernet Network Connection kern :info : [ 23.235168] igb 0000:03:00.0: eth0: (PCIe:2.5Gb/s:Width x1) 00:08:a2:0c:f4:37 kern :info : [ 23.235342] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :info : [ 23.243214] igb 0000:03:00.0: eth0: PBA No: 000300-000 kern :info : [ 23.250219] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :info : [ 23.255970] igb 0000:03:00.0: Using MSI-X interrupts. 4 rx queue(s), 4 tx queue(s) kern :info : [ 23.262446] bytcr_rt5651 bytcr_rt5651: ASoC: CPU DAI media-cpu-dai not registered kern :debug : [ 23.271108] sof-audio sof-audio: ipc: DSP is ready 0x70000000 offset 0x144000 kern :err : [ 23.279190] bytcr_rt5651 bytcr_rt5651: devm_snd_soc_register_card failed -517 kern :info : [ 23.287178] sof-audio sof-audio: Firmware info: version 1:1-64412 build 43 on Oct 17 2018:14:58:51 kern :info : [ 23.298300] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :debug : [ 23.305698] sof-audio sof-audio: found ext header type 1 size 0x88 kern :info : [ 23.312308] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :debug : [ 23.319274] sof-audio sof-audio: mailbox upstream 0x144000 - size 0x400 kern :info : [ 23.325598] bytcr_rt5651 bytcr_rt5651: ASoC: CPU DAI media-cpu-dai not registered kern :debug : [ 23.333061] sof-audio sof-audio: mailbox downstream 0x144400 - size 0x400 kern :debug : [ 23.333066] sof-audio sof-audio: stream region 0x144a00 - size 0x200 kern :debug : [ 23.333068] sof-audio sof-audio: booting DSP firmware completed kern :debug : [ 23.333074] sof-audio sof-audio: ipc rx: 0x70000000 done kern :info : [ 23.333107] sof-audio sof-audio: firmware boot complete kern :err : [ 23.341459] bytcr_rt5651 bytcr_rt5651: devm_snd_soc_register_card failed -517 kern :info : [ 23.341558] mmcblk2: p1 p2 p3 p4 kern :debug : [ 23.349202] sof-audio sof-audio: generating page table for (ptrval) size 0x10000 pages 16 kern :info : [ 23.356500] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 kern :info : [ 23.357221] [drm] Replacing VGA console driver kern :info : [ 23.358531] bytcr_rt5651 bytcr_rt5651: quirk IN1_HS_IN3_MAP enabled kern :info : [ 23.358534] bytcr_rt5651 bytcr_rt5651: quirk MCLK_EN enabled kern :info : [ 23.358545] bytcr_rt5651 bytcr_rt5651: info: override FE DAI link SSP2-Codec kern :debug : [ 23.363041] sof-audio sof-audio: pfn i 0 idx 0 pfn 749e0 kern :info : [ 23.369067] iTCO_wdt: Found a Bay Trail SoC TCO device (Version=3, TCOBASE=0x0460) kern :debug : [ 23.374833] sof-audio sof-audio: pfn i 1 idx 2 pfn 749e1 kern :info : [ 23.383014] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0) kern :debug : [ 23.386539] sof-audio sof-audio: pfn i 2 idx 5 pfn 749e2 kern :debug : [ 23.386542] sof-audio sof-audio: pfn i 3 idx 7 pfn 749e3 kern :debug : [ 23.386547] sof-audio sof-audio: pfn i 4 idx 10 pfn 749e4 kern :warn : [ 23.449394] rt5651 i2c-10EC5651:00: Warning: Invalid over-current-threshold-microamp value: 0, defaulting to 2000uA kern :debug : [ 23.456042] sof-audio sof-audio: pfn i 5 idx 12 pfn 749e5 kern :debug : [ 23.456050] sof-audio sof-audio: pfn i 6 idx 15 pfn 749e6 kern :debug : [ 23.462304] sof-audio sof-audio: loading topology:intel/sof-byt-rt5651.tplg kern :debug : [ 23.467939] sof-audio sof-audio: pfn i 7 idx 17 pfn 749e7 kern :debug : [ 23.467944] sof-audio sof-audio: pfn i 8 idx 20 pfn 749e8 kern :notice: [ 23.468896] random: fast init done kern :debug : [ 23.475623] sof-audio sof-audio: tplg: ready widget id 0 pipe 1 type 23 name : PCM0P stream Passthrough Playback 0 kern :debug : [ 23.485666] sof-audio sof-audio: pfn i 9 idx 22 pfn 749e9 kern :debug : [ 23.485669] sof-audio sof-audio: pfn i 10 idx 25 pfn 749ea kern :debug : [ 23.485672] sof-audio sof-audio: pfn i 11 idx 27 pfn 749eb kern :debug : [ 23.485675] sof-audio sof-audio: pfn i 12 idx 30 pfn 749ec kern :debug : [ 23.485677] sof-audio sof-audio: pfn i 13 idx 32 pfn 749ed kern :debug : [ 23.485680] sof-audio sof-audio: pfn i 14 idx 35 pfn 749ee kern :debug : [ 23.485682] sof-audio sof-audio: pfn i 15 idx 37 pfn 749ef kern :debug : [ 23.485685] sof-audio sof-audio: dma_trace_pages: 16 kern :debug : [ 23.485703] sof-audio sof-audio: stream_tag: -29672 kern :debug : [ 23.491766] sof-audio sof-audio: loaded host PCM0P kern :debug : [ 23.497823] sof-audio sof-audio: ipc: send 0x90010000 kern :debug : [ 23.505589] sof-audio sof-audio: config: periods snk 2 src 0 fmt 0 kern :debug : [ 23.511677] sof-audio sof-audio: ipc: 0x90010000 succeeded kern :debug : [ 23.611117] sof-audio sof-audio: ipc: send 0x30010000 kern :info : [ 23.611347] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). kern :info : [ 23.624193] [drm] Driver supports precise vblank timestamp query. kern :debug : [ 23.631605] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.637817] sof-audio sof-audio: tplg: load control type 1 name : Master Playback Volume 1 kern :debug : [ 23.647184] sof-audio sof-audio: tplg: load kcontrol index 1 chans 2 kern :debug : [ 23.654344] sof-audio sof-audio: tplg: ready widget id 1 pipe 1 type 6 name : PGA1.0 stream kern :debug : [ 23.663809] sof-audio sof-audio: config: periods snk 2 src 2 fmt 0 kern :debug : [ 23.670893] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.676621] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.682782] sof-audio sof-audio: tplg: ready widget id 2 pipe 1 type 31 name : BUF1.0 stream kern :debug : [ 23.692336] sof-audio sof-audio: buffer BUF1.0: size 384 caps 0x61 kern :info : [ 23.694060] i915 0000:00:02.0: vgaarb: changed VGA decodes: olddecodes=io+mem,decodes=io+mem:owns=io+mem kern :debug : [ 23.699320] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 23.715536] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 23.721705] sof-audio sof-audio: tplg: ready widget id 3 pipe 1 type 31 name : BUF1.1 stream kern :debug : [ 23.731258] sof-audio sof-audio: buffer BUF1.1: size 384 caps 0x61 kern :info : [ 23.733414] [drm] Initialized i915 1.6.0 20180308 for 0000:00:02.0 on minor 0 kern :debug : [ 23.738200] sof-audio sof-audio: ipc: send 0x30200000 kern :info : [ 23.747682] ACPI: Video Device [GFX0] (multi-head: yes rom: no post: no) kern :debug : [ 23.751856] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :info : [ 23.761038] acpi device:30: registered as cooling_device4 kern :debug : [ 23.765693] sof-audio sof-audio: tplg: ready widget id 4 pipe 1 type 27 name : SSP2.OUT stream SSP2-Codec kern :debug : [ 23.765700] sof-audio sof-audio: dai SSP2.OUT: type 1 index 2 kern :info : [ 23.784391] input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input4 kern :debug : [ 23.788890] sof-audio sof-audio: config: periods snk 0 src 2 fmt 0 kern :debug : [ 23.788933] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.800039] evbug: Connected device: input4 (Video Bus at LNXVIDEO/video/input0) kern :debug : [ 23.806225] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.826226] sof-audio sof-audio: tplg: check widget: SSP2.OUT stream: SSP2-Codec dai stream: SSP2-Codec kern :debug : [ 23.836743] sof-audio sof-audio: tplg: connected widget SSP2.OUT -> DAI link SSP2-Codec kern :debug : [ 23.845724] sof-audio sof-audio: tplg: ready widget id 5 pipe 1 type 32 name : PIPELINE.1.SSP2.OUT stream SSP2.OUT kern :debug : [ 23.857307] sof-audio sof-audio: tplg: pipeline id 1 comp 5 scheduling comp id 4 kern :debug : [ 23.865595] sof-audio sof-audio: pipeline PIPELINE.1.SSP2.OUT: deadline 1000 pri 0 mips 5000 core 0 frames 48 kern :debug : [ 23.876720] sof-audio sof-audio: ipc: send 0x30100000 kern :debug : [ 23.882406] sof-audio sof-audio: ipc: 0x30100000 succeeded kern :debug : [ 23.888569] sof-audio sof-audio: tplg: ready widget id 6 pipe 2 type 24 name : PCM0C stream Passthrough Capture 0 kern :debug : [ 23.900056] sof-audio sof-audio: loaded host PCM0C kern :debug : [ 23.905416] sof-audio sof-audio: config: periods snk 0 src 2 fmt 0 kern :debug : [ 23.912611] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.918293] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.924447] sof-audio sof-audio: tplg: load control type 1 name : Master Capture Volume 2 kern :debug : [ 23.933601] sof-audio sof-audio: tplg: load kcontrol index 7 chans 2 kern :debug : [ 23.940720] sof-audio sof-audio: tplg: ready widget id 7 pipe 2 type 6 name : PGA2.0 stream kern :debug : [ 23.950173] sof-audio sof-audio: config: periods snk 2 src 2 fmt 0 kern :debug : [ 23.957212] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 23.962895] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 23.969055] sof-audio sof-audio: tplg: ready widget id 8 pipe 2 type 31 name : BUF2.0 stream kern :debug : [ 23.978604] sof-audio sof-audio: buffer BUF2.0: size 384 caps 0x61 kern :debug : [ 23.985546] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 23.991227] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 23.993042] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 23.997387] sof-audio sof-audio: tplg: ready widget id 9 pipe 2 type 31 name : BUF2.1 stream kern :debug : [ 24.012861] sof-audio sof-audio: buffer BUF2.1: size 384 caps 0x61 kern :debug : [ 24.019798] sof-audio sof-audio: ipc: send 0x30200000 kern :debug : [ 24.025485] sof-audio sof-audio: ipc: 0x30200000 succeeded kern :debug : [ 24.031638] sof-audio sof-audio: tplg: ready widget id 10 pipe 2 type 28 name : SSP2.IN stream SSP2-Codec kern :debug : [ 24.042351] sof-audio sof-audio: dai SSP2.IN: type 1 index 2 kern :debug : [ 24.048688] sof-audio sof-audio: config: periods snk 2 src 0 fmt 0 kern :warn : [ 24.049089] intel_soc_dts_thermal: request_threaded_irq ret -22 kern :debug : [ 24.055725] sof-audio sof-audio: ipc: send 0x30010000 kern :debug : [ 24.068031] sof-audio sof-audio: ipc: 0x30010000 succeeded kern :debug : [ 24.074177] sof-audio sof-audio: tplg: check widget: SSP2.IN stream: SSP2-Codec dai stream: SSP2-Codec kern :debug : [ 24.084599] sof-audio sof-audio: tplg: connected widget SSP2.IN -> DAI link SSP2-Codec kern :debug : [ 24.093487] sof-audio sof-audio: tplg: ready widget id 11 pipe 2 type 32 name : PIPELINE.2.SSP2.IN stream SSP2.IN kern :info : [ 24.096288] [drm] Cannot find any crtc or sizes kern :debug : [ 24.104984] sof-audio sof-audio: tplg: pipeline id 2 comp 11 scheduling comp id 10 kern :debug : [ 24.118524] sof-audio sof-audio: pipeline PIPELINE.2.SSP2.IN: deadline 1000 pri 0 mips 5000 core 0 frames 48 kern :info : [ 24.129540] intel_rapl: Found RAPL domain package kern :info : [ 24.134810] intel_rapl: Found RAPL domain core kern :debug : [ 24.139982] sof-audio sof-audio: ipc: send 0x30100000 kern :debug : [ 24.145672] sof-audio sof-audio: ipc: 0x30100000 succeeded kern :debug : [ 24.151839] sof-audio sof-audio: tplg: load pcm Passthrough 0 kern :debug : [ 24.158286] sof-audio sof-audio: sink PCM0P control none source Passthrough Playback 0 kern :debug : [ 24.167167] sof-audio sof-audio: sink BUF1.0 control none source PCM0P kern :debug : [ 24.174496] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.180177] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.186343] sof-audio sof-audio: sink PGA1.0 control none source BUF1.0 kern :debug : [ 24.193765] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.199452] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.205625] sof-audio sof-audio: sink BUF1.1 control none source PGA1.0 kern :debug : [ 24.213053] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.218737] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.224910] sof-audio sof-audio: sink Passthrough Capture 0 control none source PCM0C kern :debug : [ 24.233703] sof-audio sof-audio: sink PCM0C control none source BUF2.0 kern :debug : [ 24.241653] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.247327] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.253478] sof-audio sof-audio: sink BUF2.0 control none source PGA2.0 kern :debug : [ 24.260904] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.266582] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.272743] sof-audio sof-audio: sink PGA2.0 control none source BUF2.1 kern :debug : [ 24.280177] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.285856] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.292030] sof-audio sof-audio: sink SSP2.OUT control none source BUF1.1 kern :debug : [ 24.299648] sof-audio sof-audio: ipc: send 0x30030000 kern :debug : [ 24.305325] sof-audio sof-audio: ipc: 0x30030000 succeeded kern :debug : [ 24.311476] sof-audio sof-audio: sink BUF2.1 control none source SSP2.IN kern :debug : [ 24.318991] sof-audio sof-audio: ipc: send 0x30030000 kern :info : [ 24.372033] raid6: sse2x1 gen() 915 MB/s kern :info : [ 24.400222] [drm] Cannot find any crtc or sizes kern :info : [ 24.444017] raid6: sse2x1 xor() 1931 MB/s kern :info : [ 24.516009] raid6: sse2x2 gen() 1608 MB/s kern :info : [ 24.588015] raid6: sse2x2 xor() 2324 MB/s kern :err : [ 24.640163] sof-audio sof-audio: error: ipc timed out for 0x30030000 size 0x10 kern :err : [ 24.648268] sof-audio sof-audio: error: unexpected fault 0x90020000 trace 0x30030000 kern :err : [ 24.656926] sof-audio sof-audio: error: waking up any trace sleepers kern :info : [ 24.660029] raid6: sse2x4 gen() 2413 MB/s kern :err : [ 24.664044] sof-audio sof-audio: error: failed to add route sink BUF2.1 control none source SSP2.IN kern :debug : [ 24.678942] sof-audio sof-audio: tplg: config SSP0 fmt 0x4001 mclk 19200000 bclk 1920000 fclk 48000 width (16)20 slots 2 mclk id 0 kern :debug : [ 24.692104] sof-audio sof-audio: ipc: send 0x80010000 kern :info : [ 24.736007] raid6: sse2x4 xor() 2143 MB/s kern :info : [ 24.740786] raid6: using algorithm sse2x4 gen() 2413 MB/s kern :info : [ 24.746823] raid6: .... xor() 2143 MB/s, rmw enabled kern :info : [ 24.752376] raid6: using ssse3x2 recovery algorithm kern :debug : [ 24.757864] sof-audio sof-audio: ipc: 0x80010000 succeeded kern :debug : [ 24.757907] sof-audio sof-audio: ipc rx: 0x90020000 done kern :warn : [ 24.764018] sof-audio sof-audio: ASoC: Parent card not yet available, widget card binding deferred kern :debug : [ 24.779991] sof-audio sof-audio: tplg: complete pipeline PIPELINE.2.SSP2.IN id 11 kern :debug : [ 24.788380] sof-audio sof-audio: ipc: send 0x30130000 kern :debug : [ 24.794051] sof-audio sof-audio: ipc: 0x30130000 succeeded kern :info : [ 24.794285] xor: measuring software checksum speed kern :debug : [ 24.800195] sof-audio sof-audio: tplg: complete pipeline PIPELINE.1.SSP2.OUT id 5 kern :debug : [ 24.813937] sof-audio sof-audio: ipc: send 0x30130000 kern :debug : [ 24.819611] sof-audio sof-audio: ipc: 0x30130000 succeeded kern :info : [ 24.825976] bytcr_rt5651 bytcr_rt5651: rt5651-aif1 <-> ssp2-port mapping ok kern :debug : [ 24.833841] sof-audio sof-audio: creating new PCM Passthrough kern :debug : [ 24.840274] sof-audio sof-audio: spcm: allocate Passthrough Playback 0 playback DMA buffer size 0x10000 max 0x10000 kern :info : [ 24.844138] prefetch64-sse: 5895.000 MB/sec kern :debug : [ 24.851993] sof-audio sof-audio: spcm: allocate Passthrough Capture 0 capture DMA buffer size 0x10000 max 0x10000 kern :info : [ 24.868526] bytcr_rt5651 bytcr_rt5651: snd-soc-dummy-dai <-> Passthrough 0 mapping ok kern :info : [ 24.896566] generic_sse: 5859.000 MB/sec kern :info : [ 24.901347] xor: using function: prefetch64-sse (5895.000 MB/sec) kern :info : [ 24.956359] [drm] Cannot find any crtc or sizes kern :debug : [ 24.983339] sof-audio sof-audio: ipc rx: 0x90020000 done kern :info : [ 25.020653] Btrfs loaded, crc32c=crc32c-intel kern :info : [ 25.319432] BTRFS: device label LKP-ROOTFS devid 1 transid 1749 /dev/mmcblk2p4 kern :info : [ 25.430709] BTRFS info (device mmcblk2p4): disk space caching is enabled kern :info : [ 25.471913] BTRFS info (device mmcblk2p4): enabling ssd optimizations daemon:info : [ 29.001782] systemd[1]: RTC configured in localtime, applying delta of 480 minutes to system time. daemon:info : [ 29.012398] systemd[1]: System time before build time, advancing clock. kern :notice: [ 29.419937] random: systemd: uninitialized urandom read (16 bytes read) kern :notice: [ 29.435276] random: systemd: uninitialized urandom read (16 bytes read) kern :notice: [ 29.460603] random: systemd: uninitialized urandom read (16 bytes read) kern :info : [ 29.973896] RPC: Registered named UNIX socket transport module. kern :info : [ 29.981841] RPC: Registered udp transport module. kern :info : [ 29.987347] RPC: Registered tcp transport module. kern :info : [ 29.992873] RPC: Registered tcp NFSv4.1 backchannel transport module. kern :info : [ 30.105575] lp: driver loaded but no devices found kern :info : [ 30.116807] ppdev: user-space parallel port driver kern :info : [ 44.629581] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready kern :info : [ 44.688727] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready kern :info : [ 47.540639] igb 0000:03:00.0 eth0: igb: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX kern :info : [ 47.656562] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready user :notice: [ 60.532674] Kernel tests: Boot OK! kern :info : [ 64.835215] netpoll: netconsole: local port 6665 kern :info : [ 64.840411] netpoll: netconsole: local IPv4 address 0.0.0.0 kern :info : [ 64.846676] netpoll: netconsole: interface 'eth0' kern :info : [ 64.851987] netpoll: netconsole: remote port 6653 kern :info : [ 64.857287] netpoll: netconsole: remote IPv4 address 192.168.1.1 kern :info : [ 64.864033] netpoll: netconsole: remote ethernet address ff:ff:ff:ff:ff:ff kern :info : [ 64.871819] netpoll: netconsole: local IP 192.168.1.215 kern :info : [ 64.877815] console [netcon0] enabled kern :info : [ 64.881968] netconsole: network logging started kern :notice: [ 65.226460] FS-Cache: Loaded kern :notice: [ 65.265753] FS-Cache: Netfs 'nfs' registered for caching user :notice: [ 71.994675] 17 Oct 23:13:52 ntpdate[860]: step time server 192.168.1.1 offset 30763131.237294 sec user :notice: [ 72.008508] /lkp/lkp/src/bin/run-lkp kern :notice: [ 81.824578] random: crng init done kern :notice: [ 81.828399] random: 6 urandom warning(s) missed due to ratelimiting user :notice: [ 84.963036] RESULT_ROOT=/result/sof_test/defaults/sof-minnow/ubuntu-x86_64-2018-02-07-sof/x86_64-sof-V4.18-config/gcc-7/9b33dfacf8f0c9fffc22b1cdd5556faad31ed133/644120ad02935dff56ae9db7268b97594eab2e56/7f47792cbd22886d5fe2acbd229a13a6ea138e66/0 user :notice: [ 85.003284] job=/lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181017-18-1ostgqk-0.yaml user :notice: [ 85.023522] mount.nfs: try 1 time... user :notice: [ 85.044037] run-job /lkp/jobs/scheduled/sof-minnow-2/sof_test-defaults-ubuntu-x86_64-2018-02-07-sof-9b33dfacf8f0c9fffc22b1cdd5556faad31ed133-20181017-18-1ostgqk-0.yaml user :notice: [ 90.941041] /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-20181017-18-1ostgqk-0.yaml&job_state=running -O /dev/null user :notice: [ 90.977507] target ucode: user :notice: [ 90.988634] IPMI BMC is not supported on this machine, skip bmc-watchdog setup! user :notice: [ 91.004087] current path is = /lkp/benchmarks/sof_test/audio_sof_test.git user :notice: [ 91.025035] whereis alsabat : alsabat: /usr/bin/alsabat /lkp/benchmarks/sof_test/installation/bin/alsabat /usr/share/man/man1/alsabat.1.gz user :notice: [ 91.043989] whereis rmbox : rmbox: /usr/bin/rmbox user :notice: [ 192.252985] verify_sof_firmware_presence PASS user :notice: [ 195.910778] verify_sof_firmware_load PASS user :err : [ 197.867910] Found hardware: "sof-bytcr-rt565" "" "" "" "" user :err : [ 197.997081] Hardware is initialized using a generic method user :notice: [ 199.795842] verify_sof_firmware_version_info PASS user :err : [ 203.088438] alsactl: set_control:1325: failed to obtain info for control #22 (No such file or directory) user :err : [ 203.109354] alsactl: set_control:1325: failed to obtain info for control #23 (No such file or directory) user :notice: [ 207.876306] playack_pcm_list PASS user :notice: [ 210.084968] verify_sound_modules PASS user :notice: [ 212.339631] capture_pcm_list PASS user :notice: [ 216.444469] verify_playback_pcm_list PASS kern :debug : [ 220.118059] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 220.124143] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 220.131125] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 220.137218] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 220.143811] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 220.150568] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 220.157333] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 user :err : [ 220.160440] Playing raw data '/dev/zero' : Signed 16 bit Little Endian, Rate 48000 Hz, Stereo kern :debug : [ 220.164076] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 220.182140] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 220.189135] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 220.196186] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 220.203030] sof-audio sof-audio: generating page table for 000000009dceb8fb size 0xff00 pages 16 kern :debug : [ 220.213082] sof-audio sof-audio: pfn i 0 idx 0 pfn 74010 kern :debug : [ 220.219295] sof-audio sof-audio: pfn i 1 idx 2 pfn 74011 kern :debug : [ 220.225487] sof-audio sof-audio: pfn i 2 idx 5 pfn 74012 kern :debug : [ 220.231681] sof-audio sof-audio: pfn i 3 idx 7 pfn 74013 kern :debug : [ 220.237932] sof-audio sof-audio: pfn i 4 idx 10 pfn 74014 kern :debug : [ 220.244250] sof-audio sof-audio: pfn i 5 idx 12 pfn 74015 kern :debug : [ 220.250501] sof-audio sof-audio: pfn i 6 idx 15 pfn 74016 kern :debug : [ 220.256810] sof-audio sof-audio: pfn i 7 idx 17 pfn 74017 kern :debug : [ 220.263122] sof-audio sof-audio: pfn i 8 idx 20 pfn 74018 kern :debug : [ 220.269435] sof-audio sof-audio: pfn i 9 idx 22 pfn 74019 kern :debug : [ 220.275725] sof-audio sof-audio: pfn i 10 idx 25 pfn 7401a kern :debug : [ 220.282139] sof-audio sof-audio: pfn i 11 idx 27 pfn 7401b kern :debug : [ 220.288551] sof-audio sof-audio: pfn i 12 idx 30 pfn 7401c kern :debug : [ 220.294706] sof-audio sof-audio: pfn i 13 idx 32 pfn 7401d kern :debug : [ 220.301144] sof-audio sof-audio: pfn i 14 idx 35 pfn 7401e kern :debug : [ 220.307555] sof-audio sof-audio: pfn i 15 idx 37 pfn 7401f kern :debug : [ 220.313964] sof-audio sof-audio: stream_tag 0 kern :debug : [ 220.319435] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 220.325755] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 220.504977] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 220.735068] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 220.742164] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 220.748103] sof-audio sof-audio: ipc: 0x60040000 succeeded kern :debug : [ 220.999996] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 221.381099] sof-audio sof-audio: PCM: stream 0 dir 0 DMA position 0 DAI position 0 kern :debug : [ 221.921416] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 221.928869] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 221.934679] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc user :err : [ 221.936857] aplay: pcm_write:2051: write error: Input/output error kern :err : [ 221.942421] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 221.956730] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 221.963076] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 221.969039] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 221.975444] sof-audio sof-audio: pcm: close stream 0 dir 0 user :notice: [ 221.985533] Aplay FAIL user :notice: [ 221.991352] check_aplay FAIL kern :debug : [ 222.215311] sof-audio sof-audio: ipc rx: 0x90020000 done user :notice: [ 226.325944] check_dma_trace PASS kern :debug : [ 230.289552] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 230.295342] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 230.301631] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 230.307548] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 230.404814] sof-audio sof-audio: ipc rx: 0x90020000 done user :err : [ 231.118933] /lkp/benchmarks/sof_test/audio_sof_test.git/functionality_test/check_dma_trace.sh: line 2: 1224 Killed rmbox -t > rmbox.log kern :debug : [ 232.342664] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 232.348835] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 232.355496] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 232.361268] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 232.367311] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 232.374219] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 232.381097] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 232.387975] sof-audio sof-audio: generating page table for 000000009dceb8fb size 0xff00 pages 16 kern :debug : [ 232.398448] sof-audio sof-audio: pfn i 0 idx 0 pfn 74010 kern :debug : [ 232.404413] sof-audio sof-audio: pfn i 1 idx 2 pfn 74011 kern :debug : [ 232.410371] sof-audio sof-audio: pfn i 2 idx 5 pfn 74012 kern :debug : [ 232.416673] sof-audio sof-audio: pfn i 3 idx 7 pfn 74013 kern :debug : [ 232.422634] sof-audio sof-audio: pfn i 4 idx 10 pfn 74014 kern :debug : [ 232.429066] sof-audio sof-audio: pfn i 5 idx 12 pfn 74015 kern :debug : [ 232.435263] sof-audio sof-audio: pfn i 6 idx 15 pfn 74016 kern :debug : [ 232.441656] sof-audio sof-audio: pfn i 7 idx 17 pfn 74017 kern :debug : [ 232.448072] sof-audio sof-audio: pfn i 8 idx 20 pfn 74018 kern :debug : [ 232.454497] sof-audio sof-audio: pfn i 9 idx 22 pfn 74019 kern :debug : [ 232.461267] sof-audio sof-audio: pfn i 10 idx 25 pfn 7401a kern :debug : [ 232.467423] sof-audio sof-audio: pfn i 11 idx 27 pfn 7401b kern :debug : [ 232.473913] sof-audio sof-audio: pfn i 12 idx 30 pfn 7401c kern :debug : [ 232.480208] sof-audio sof-audio: pfn i 13 idx 32 pfn 7401d kern :debug : [ 232.486598] sof-audio sof-audio: pfn i 14 idx 35 pfn 7401e kern :debug : [ 232.492932] sof-audio sof-audio: pfn i 15 idx 37 pfn 7401f kern :debug : [ 232.499231] sof-audio sof-audio: stream_tag 0 kern :debug : [ 232.504402] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 232.510083] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 232.579313] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 232.586699] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 232.592670] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 232.600621] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 232.606288] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 232.613818] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 232.620128] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 232.627879] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 232.633714] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 232.640678] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 232.646551] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 232.654556] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 232.660222] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 232.667663] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 232.674018] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 232.681795] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 232.687956] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 232.695283] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 232.700947] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 232.708641] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 232.714311] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 232.721834] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 232.727501] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 232.735582] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 232.741354] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 232.748442] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 232.754119] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 232.762179] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 232.767858] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 232.775443] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 232.781122] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 232.788842] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 232.794623] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 232.802011] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 232.807683] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 232.815734] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 232.821414] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 232.828855] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 232.834865] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 232.835117] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :debug : [ 232.836329] sof-audio sof-audio: pcm: open stream 0 dir 1 kern :debug : [ 232.836340] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 232.836347] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 232.836354] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 232.836706] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 232.836714] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 232.836727] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 232.836734] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 232.836751] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 232.836757] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 232.836769] sof-audio sof-audio: pcm: hw params stream 0 dir 1 kern :debug : [ 232.836781] sof-audio sof-audio: generating page table for 000000008e544456 size 0xff00 pages 16 kern :debug : [ 232.836789] sof-audio sof-audio: pfn i 0 idx 0 pfn 74020 kern :debug : [ 232.836796] sof-audio sof-audio: pfn i 1 idx 2 pfn 74021 kern :debug : [ 232.836804] sof-audio sof-audio: pfn i 2 idx 5 pfn 74022 kern :debug : [ 232.836811] sof-audio sof-audio: pfn i 3 idx 7 pfn 74023 kern :debug : [ 232.836818] sof-audio sof-audio: pfn i 4 idx 10 pfn 74024 kern :debug : [ 232.836825] sof-audio sof-audio: pfn i 5 idx 12 pfn 74025 kern :debug : [ 232.836833] sof-audio sof-audio: pfn i 6 idx 15 pfn 74026 kern :debug : [ 232.836840] sof-audio sof-audio: pfn i 7 idx 17 pfn 74027 kern :debug : [ 232.836847] sof-audio sof-audio: pfn i 8 idx 20 pfn 74028 kern :debug : [ 232.836855] sof-audio sof-audio: pfn i 9 idx 22 pfn 74029 kern :debug : [ 232.836862] sof-audio sof-audio: pfn i 10 idx 25 pfn 7402a kern :debug : [ 232.836869] sof-audio sof-audio: pfn i 11 idx 27 pfn 7402b kern :debug : [ 232.836876] sof-audio sof-audio: pfn i 12 idx 30 pfn 7402c kern :debug : [ 232.836884] sof-audio sof-audio: pfn i 13 idx 32 pfn 7402d kern :debug : [ 232.836891] sof-audio sof-audio: pfn i 14 idx 35 pfn 7402e kern :debug : [ 232.836898] sof-audio sof-audio: pfn i 15 idx 37 pfn 7402f kern :debug : [ 232.836905] sof-audio sof-audio: stream_tag 0 kern :err : [ 233.031229] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 233.037208] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 233.037645] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 233.042878] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 233.045361] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 1 kern :debug : [ 233.050002] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 233.068654] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 233.076299] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 233.081980] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 233.089504] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 233.095621] sof-audio sof-audio: ipc: 0x60040000 succeeded kern :debug : [ 233.102298] sof-audio sof-audio: PCM: stream 0 dir 1 DMA position 0 DAI position 0 kern :debug : [ 233.110822] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 233.116976] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 233.124870] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 233.130676] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 233.137631] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 233.143454] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 233.151139] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 233.156814] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 233.163783] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 233.169839] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 233.177505] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 233.183276] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 233.190725] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 233.196387] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 233.204046] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 233.209711] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 233.216663] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 233.222163] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 233.222450] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 233.236088] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 233.633028] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 0 kern :debug : [ 233.640483] sof-audio sof-audio: ipc: send 0x60050000 user :err : [ 233.643916] Read PCM device error: Input/output error(-5) kern :err : [ 233.646285] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 233.646370] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 233.667938] sof-audio sof-audio: pcm: free stream 0 dir 1 kern :debug : [ 233.674563] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 233.680725] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 233.687627] sof-audio sof-audio: pcm: close stream 0 dir 1 kern :debug : [ 234.095116] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 234.272133] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 user :err : [ 234.276285] Write PCM device error: Input/output error(-5) kern :debug : [ 234.279115] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 234.292513] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 234.300157] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 234.707099] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 244.448487] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 244.455866] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 244.461675] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 244.469439] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 244.475144] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 244.481747] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 244.487892] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 244.494694] sof-audio sof-audio: pcm: close stream 0 dir 0 user :err : [ 244.504990] Exit playback thread fail: -5 user :notice: [ 244.507275] alsa-utils version 1.1.6 user :notice: [ 244.521976] Entering playback thread (ALSA). user :notice: [ 244.532591] Get period size: 2112 buffer size: 16320 user :notice: [ 244.543125] Playing generated audio sine wave user :notice: [ 244.552940] Entering capture thread (ALSA). user :notice: [ 244.563285] Get period size: 2112 buffer size: 16320 user :notice: [ 244.572410] Recording ... user :notice: [ 244.581039] Fail: line in/out mode playback test failed. user :notice: [ 244.593104] Check_volume_line_in_out_48k_dat_playback FAIL kern :debug : [ 245.101871] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 248.251582] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 248.257581] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 248.263819] sof-audio sof-audio: ipc: send 0x50010000 kern :debug : [ 248.269541] sof-audio sof-audio: ipc: 0x50010000 succeeded kern :debug : [ 248.566851] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 250.305012] sof-audio sof-audio: pcm: open stream 0 dir 0 kern :debug : [ 250.311186] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 250.317840] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 250.323870] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 250.330207] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 250.337032] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 250.343902] sof-audio sof-audio: pcm: hw params stream 0 dir 0 kern :debug : [ 250.350746] sof-audio sof-audio: generating page table for 000000009dceb8fb size 0xff00 pages 16 kern :debug : [ 250.360850] sof-audio sof-audio: pfn i 0 idx 0 pfn 74010 kern :debug : [ 250.366977] sof-audio sof-audio: pfn i 1 idx 2 pfn 74011 kern :debug : [ 250.373000] sof-audio sof-audio: pfn i 2 idx 5 pfn 74012 kern :debug : [ 250.379021] sof-audio sof-audio: pfn i 3 idx 7 pfn 74013 kern :debug : [ 250.385042] sof-audio sof-audio: pfn i 4 idx 10 pfn 74014 kern :debug : [ 250.391128] sof-audio sof-audio: pfn i 5 idx 12 pfn 74015 kern :debug : [ 250.397248] sof-audio sof-audio: pfn i 6 idx 15 pfn 74016 kern :debug : [ 250.403441] sof-audio sof-audio: pfn i 7 idx 17 pfn 74017 kern :debug : [ 250.409536] sof-audio sof-audio: pfn i 8 idx 20 pfn 74018 kern :debug : [ 250.415710] sof-audio sof-audio: pfn i 9 idx 22 pfn 74019 kern :debug : [ 250.421830] sof-audio sof-audio: pfn i 10 idx 25 pfn 7401a kern :debug : [ 250.428018] sof-audio sof-audio: pfn i 11 idx 27 pfn 7401b kern :debug : [ 250.434343] sof-audio sof-audio: pfn i 12 idx 30 pfn 7401c kern :debug : [ 250.440697] sof-audio sof-audio: pfn i 13 idx 32 pfn 7401d kern :debug : [ 250.446856] sof-audio sof-audio: pfn i 14 idx 35 pfn 7401e kern :debug : [ 250.453070] sof-audio sof-audio: pfn i 15 idx 37 pfn 7401f kern :debug : [ 250.459290] sof-audio sof-audio: stream_tag 0 kern :debug : [ 250.464489] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 250.470175] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 250.478339] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.485564] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.492202] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.500195] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.505900] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.513442] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 250.519105] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 250.527377] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.533147] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.540381] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 250.546399] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 250.546594] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.560116] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.565801] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.572737] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 250.578400] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 250.586336] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.592648] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.600012] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.605674] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.613959] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.619634] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.626870] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 250.632526] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 250.640198] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.645983] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.653341] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.659003] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.667017] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.672684] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.680205] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 250.685869] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 250.693785] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.699556] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.707049] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.712720] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.720689] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.726364] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.733820] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 250.739500] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 250.747224] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.753013] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.760483] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.766158] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 250.774084] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 250.779802] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 250.787532] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 250.793509] sof-audio sof-audio: ipc rx: 0x90020000 done kern :err : [ 250.793943] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :debug : [ 250.795599] sof-audio sof-audio: pcm: open stream 0 dir 1 kern :debug : [ 250.795604] sof-audio sof-audio: period min 192 max 16384 bytes kern :debug : [ 250.795606] sof-audio sof-audio: period count 2 max 16 kern :debug : [ 250.795609] sof-audio sof-audio: buffer max 65536 bytes kern :debug : [ 250.795747] sof-audio sof-audio: rate_min: 48000 rate_max: 48000 kern :debug : [ 250.795750] sof-audio sof-audio: channels_min: 2 channels_max: 2 kern :debug : [ 250.795755] sof-audio sof-audio: pcm: hw params stream 0 dir 1 kern :debug : [ 250.795759] sof-audio sof-audio: generating page table for 000000008e544456 size 0xff00 pages 16 kern :debug : [ 250.795763] sof-audio sof-audio: pfn i 0 idx 0 pfn 74020 kern :debug : [ 250.795765] sof-audio sof-audio: pfn i 1 idx 2 pfn 74021 kern :debug : [ 250.795768] sof-audio sof-audio: pfn i 2 idx 5 pfn 74022 kern :debug : [ 250.795771] sof-audio sof-audio: pfn i 3 idx 7 pfn 74023 kern :debug : [ 250.795773] sof-audio sof-audio: pfn i 4 idx 10 pfn 74024 kern :debug : [ 250.795776] sof-audio sof-audio: pfn i 5 idx 12 pfn 74025 kern :debug : [ 250.795779] sof-audio sof-audio: pfn i 6 idx 15 pfn 74026 kern :debug : [ 250.795781] sof-audio sof-audio: pfn i 7 idx 17 pfn 74027 kern :debug : [ 250.795784] sof-audio sof-audio: pfn i 8 idx 20 pfn 74028 kern :debug : [ 250.795787] sof-audio sof-audio: pfn i 9 idx 22 pfn 74029 kern :debug : [ 250.795789] sof-audio sof-audio: pfn i 10 idx 25 pfn 7402a kern :debug : [ 250.795792] sof-audio sof-audio: pfn i 11 idx 27 pfn 7402b kern :debug : [ 250.795795] sof-audio sof-audio: pfn i 12 idx 30 pfn 7402c kern :debug : [ 250.795797] sof-audio sof-audio: pfn i 13 idx 32 pfn 7402d kern :debug : [ 250.795800] sof-audio sof-audio: pfn i 14 idx 35 pfn 7402e kern :debug : [ 250.795803] sof-audio sof-audio: pfn i 15 idx 37 pfn 7402f kern :debug : [ 250.795805] sof-audio sof-audio: stream_tag 0 kern :err : [ 250.963109] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 250.968814] sof-audio sof-audio: ipc: send 0x60010000 kern :debug : [ 250.972281] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 250.974517] sof-audio sof-audio: ipc: 0x60010000 succeeded kern :debug : [ 250.987611] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 250.993279] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 251.000922] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 251.006585] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 251.014106] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 251.019928] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :debug : [ 251.023338] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 1 kern :err : [ 251.027956] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 251.040813] sof-audio sof-audio: ipc: send 0x60040000 kern :debug : [ 251.044732] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :err : [ 251.046479] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 251.061058] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 251.066724] sof-audio sof-audio: pcm: trigger stream 0 dir 1 cmd 0 kern :debug : [ 251.074338] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 251.080637] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc kern :err : [ 251.088594] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 251.094274] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 251.101613] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 251.107269] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 251.114942] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 251.120618] sof-audio sof-audio: ipc: send 0x60050000 kern :debug : [ 251.122544] sof-audio sof-audio: pcm: free stream 0 dir 1 kern :err : [ 251.126446] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 251.126506] Passthrough: ASoC: trigger FE failed -62 user :err : [ 251.127344] Read PCM device error: Device or resource busy(-16) kern :debug : [ 251.154846] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 251.160781] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 251.167637] sof-audio sof-audio: pcm: close stream 0 dir 1 kern :debug : [ 251.287965] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 251.782975] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 252.160664] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 1 kern :debug : [ 252.167727] sof-audio sof-audio: ipc: send 0x60040000 kern :err : [ 252.173444] sof-audio sof-audio: error: ipc error for 0x60040000 size 0xc user :err : [ 252.176092] Write PCM device error: Input/output error(-5) kern :err : [ 252.181176] Passthrough: ASoC: trigger FE failed -16 kern :debug : [ 252.277955] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 262.368469] sof-audio sof-audio: pcm: trigger stream 0 dir 0 cmd 0 kern :debug : [ 262.375753] sof-audio sof-audio: ipc: send 0x60050000 kern :err : [ 262.381893] sof-audio sof-audio: error: ipc error for 0x60050000 size 0xc kern :err : [ 262.389774] Passthrough: ASoC: trigger FE failed -62 kern :debug : [ 262.395466] sof-audio sof-audio: pcm: free stream 0 dir 0 kern :debug : [ 262.402033] sof-audio sof-audio: ipc: send 0x60030000 kern :debug : [ 262.408313] sof-audio sof-audio: ipc: 0x60030000 succeeded kern :debug : [ 262.414870] sof-audio sof-audio: pcm: close stream 0 dir 0 user :notice: [ 262.429883] alsa-utils version 1.1.6 user :err : [ 262.430435] Exit playback thread fail: -5 user :notice: [ 262.446439] Entering playback thread (ALSA). user :notice: [ 262.456601] Get period size: 2112 buffer size: 16320 user :notice: [ 262.466892] Playing generated audio sine wave user :notice: [ 262.476216] Entering capture thread (ALSA). user :notice: [ 262.486252] Get period size: 2112 buffer size: 16320 user :notice: [ 262.494766] Recording ... user :notice: [ 262.503055] Fail: dual channels playback test failed. user :notice: [ 262.514929] Check_volume_dual_channels_48000_dat_playback FAIL kern :debug : [ 262.672801] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 280.376581] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 280.382319] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 280.388761] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 280.394501] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 280.400836] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 280.406545] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 280.413162] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 280.418878] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 280.437594] get_mixer_properties PASS kern :debug : [ 280.492535] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 286.465532] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 286.471831] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 286.478127] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 286.483973] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 286.490632] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 286.496346] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 286.502905] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 286.508617] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 286.544134] set_HP_volume_to_minimum PASS kern :debug : [ 286.927345] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 294.542377] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 294.548349] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 294.554939] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 294.561037] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 294.568345] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 294.574099] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 294.580520] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 294.586232] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 294.624212] set_HP_volume_to_maximum PASS kern :debug : [ 294.847224] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 298.587185] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 298.593319] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 298.599873] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 298.605622] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 298.612107] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 298.618062] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 298.624686] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 298.630394] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 298.668946] set_ADC_volume_to_minimum PASS kern :debug : [ 298.807123] sof-audio sof-audio: ipc rx: 0x90020000 done kern :debug : [ 301.500884] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 301.506675] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 301.512894] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 301.518615] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 301.525015] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 301.530736] sof-audio sof-audio: ipc: 0x50020000 succeeded kern :debug : [ 301.537396] sof-audio sof-audio: ipc: send 0x50020000 kern :debug : [ 301.543113] sof-audio sof-audio: ipc: 0x50020000 succeeded user :notice: [ 301.582496] set_ADC_volume_to_maximum PASS kern :debug : [ 301.777083] sof-audio sof-audio: ipc rx: 0x90020000 done user :notice: [ 304.753424] /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-20181017-18-1ostgqk-0.yaml&job_state=post_run -O /dev/null user :notice: [ 307.695670] kill 984 vmstat --timestamp -n 10