early console in setup code
early console in extract_kernel
input_data: 0x00000000038c3255
input_len: 0x00000000008a4c8e
output: 0x0000000001000000
output_len: 0x0000000001b9b960
kernel_total_size: 0x0000000003184000

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[    0.000000] Linux version 4.9.0-rc6-00134-gb1e955c (kbuild@intel11) (gcc version 4.4.7 (Debian 4.4.7-8) ) #1 SMP PREEMPT Wed Feb 8 11:24:40 CST 2017
[    0.000000] Command line: ip=::::vm-lkp-os-openwrt-ia32-16::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s1-02070724 branch=linux-devel/devel-spot-201702070625 commit=b1e955caea7e3ae340ebd5392a7fe4478f64ce1d BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/vmlinuz-4.9.0-rc6-00134-gb1e955c max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-os-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 systemd.log_level=err ignore_loglevel earlyprintk=ttyS0,115200 console=ttyS0,115200 cons
[    0.000000] KERNEL supported cpus:
[    0.000000]   AMD AuthenticAMD
[    0.000000] x86/fpu: Legacy x87 FPU detected.
[    0.000000] x86/fpu: Using 'eager' FPU context switches.
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000013fdffff] usable
[    0.000000] BIOS-e820: [mem 0x0000000013fe0000-0x0000000013ffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] debug: ignoring loglevel setting.
[    0.000000] bootconsole [earlyser0] enabled
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.8 present.
[    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] e820: last_pfn = 0x13fe0 max_arch_pfn = 0x400000000
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] BRK [0x0415f000, 0x0415ffff] PGTABLE
[    0.000000] BRK [0x04160000, 0x04160fff] PGTABLE
[    0.000000] BRK [0x04161000, 0x04161fff] PGTABLE
[    0.000000] BRK [0x04162000, 0x04162fff] PGTABLE
[    0.000000] RAMDISK: [mem 0x13306000-0x13fdffff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F69C0 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x0000000013FE18DC 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x0000000013FE17B8 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x0000000013FE0040 001778 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x0000000013FE0000 000040
[    0.000000] ACPI: APIC 0x0000000013FE182C 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x0000000013FE18A4 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] mapped APIC to ffffffffff5fd000 (        fee00000)
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   DMA32    [mem 0x0000000001000000-0x0000000013fdffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x0000000013fdffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000013fdffff]
[    0.000000] On node 0 totalpages: 81790
[    0.000000]   DMA zone: 56 pages used for memmap
[    0.000000]   DMA zone: 21 pages reserved
[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 1064 pages used for memmap
[    0.000000]   DMA32 zone: 77792 pages, LIFO batch:15
[    0.000000] ACPI: PM-Timer IO Port: 0x608
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[    0.000000] ACPI: IRQ5 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] ACPI: IRQ10 used by override.
[    0.000000] ACPI: IRQ11 used by override.
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[    0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000)
[    0.000000] e820: [mem 0x14000000-0xfffbffff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on bare hardware
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] percpu: Embedded 481 pages/cpu @ffff880013000000 s1932032 r8192 d29952 u2097152
[    0.000000] pcpu-alloc: s1932032 r8192 d29952 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 80649
[    0.000000] Kernel command line: ip=::::vm-lkp-os-openwrt-ia32-16::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s1-02070724 branch=linux-devel/devel-spot-201702070625 commit=b1e955caea7e3ae340ebd5392a7fe4478f64ce1d BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/vmlinuz-4.9.0-rc6-00134-gb1e955c max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-os-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 systemd.log_level=err ignore_loglevel earlyprintk=ttyS0,115200 console=ttyS0,1152
[    0.000000] sysrq: sysrq always enabled.
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.000000] Memory: 255228K/327160K available (11720K kernel code, 2325K rwdata, 4500K rodata, 3388K init, 26380K bss, 71932K reserved, 0K cma-reserved)
[    0.000000] Running RCU self tests
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1
[    0.000000] NR_IRQS:4352 nr_irqs:256 16
[    0.000000] console [ttyS0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] bootconsole [earlyser0] disabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.000000] ... MAX_LOCKDEP_CHAINS:      65536
[    0.000000] ... CHAINHASH_SIZE:          32768
[    0.000000]  memory used by lock dependency info: 8671 kB
[    0.000000]  per task-struct memory footprint: 2688 bytes
[    0.000000] ------------------------
[    0.000000] | Locking API testsuite:
[    0.000000] ----------------------------------------------------------------------------
[    0.000000]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]                      A-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]                  A-B-B-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]              A-B-B-C-C-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]              A-B-C-A-B-C deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]          A-B-B-C-C-D-D-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]          A-B-C-D-B-D-D-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]          A-B-C-D-B-C-D-A deadlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]                     double unlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]                   initialize held:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]                  bad unlock order:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]               recursive read-lock:
[    0.000000]              |
  ok  |
[    0.000000]              |
  ok  |
[    0.000000] 
[    0.000000]            recursive read-lock #2:
[    0.000000]              |
  ok  |
[    0.000000]              |
  ok  |
[    0.000000] 
[    0.000000]             mixed read-write-lock:
[    0.000000]              |
  ok  |
[    0.000000]              |
  ok  |
[    0.000000] 
[    0.000000]             mixed write-read-lock:
[    0.000000]              |
  ok  |
[    0.000000]              |
  ok  |
[    0.000000] 
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]      hard-irqs-on + irq-safe-A/12:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]      soft-irqs-on + irq-safe-A/12:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]      hard-irqs-on + irq-safe-A/21:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]      soft-irqs-on + irq-safe-A/21:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]        sirq-safe-A => hirqs-on/12:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]        sirq-safe-A => hirqs-on/21:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]          hard-safe-A + irqs-on/12:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]          soft-safe-A + irqs-on/12:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]          hard-safe-A + irqs-on/21:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]          soft-safe-A + irqs-on/21:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #1/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #1/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     hard-safe-A + unsafe-B #2/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]     soft-safe-A + unsafe-B #2/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/123:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/132:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/213:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/231:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/312:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq lock-inversion/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq lock-inversion/321:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/123:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/123:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/132:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/132:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/213:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/213:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/231:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/231:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/312:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/312:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       hard-irq read-recursion/321:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]       soft-irq read-recursion/321:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]   --------------------------------------------------------------------------
[    0.000000]   | Wound/wait tests |
[    0.000000]   ---------------------
[    0.000000]                   ww api failures:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]                ww contexts mixing:
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]              finishing ww context:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]                locking mismatches:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]                  EDEADLK handling:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
  ok  |
[    0.000000] 
[    0.000000]            spinlock nest unlocked:
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]   -----------------------------------------------------
[    0.000000]                                  |block | try  |context|
[    0.000000]   -----------------------------------------------------
[    0.000000]                           context:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]                               try:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]                             block:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000]                          spinlock:
[    0.000000]   ok  |
  ok  |
[    0.000000]   ok  |
[    0.000000] 
[    0.000000] -------------------------------------------------------
[    0.000000] Good, all 253 testcases passed! |
[    0.000000] ---------------------------------
[    0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Fast TSC calibration failed
[    0.000000] tsc: Unable to calibrate against PIT
[    0.000000] tsc: using HPET reference calibration
[    0.000000] tsc: Detected 3199.860 MHz processor
[    0.093799] Calibrating delay loop (skipped), value calculated using timer frequency.. 6399.72 BogoMIPS (lpj=31998600)
[    0.102439] pid_max: default: 32768 minimum: 301
[    0.106822] ACPI: Core revision 20160831
[    1.184497] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    1.195681] Security Framework initialized
[    1.203836] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    1.205680] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[    1.431797] mce: CPU supports 10 MCE banks
[    1.442120] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    1.443467] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    2.562110] random: fast init done
[    2.867529] Freeing SMP alternatives memory: 20K (ffffffff82796000 - ffffffff8279b000)
[    2.948532] ftrace: allocating 26476 entries in 104 pages
[    3.364422] smpboot: APIC(0) Converting physical 0 to logical package 0
[    3.366846] smpboot: Max logical packages: 1
[    3.378927] enabled ExtINT on CPU#0
[    3.388212] ENABLING IO-APIC IRQs
[    3.392222] init IO_APIC IRQs
[    3.393026]  apic 0 pin 0 not connected
[    3.403887] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[    3.412827] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[    3.415433] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[    3.417942] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[    3.420000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[    3.420000]  apic 0 pin 16 not connected
[    3.420000]  apic 0 pin 17 not connected
[    3.420000]  apic 0 pin 18 not connected
[    3.420000]  apic 0 pin 19 not connected
[    3.420000]  apic 0 pin 20 not connected
[    3.420000]  apic 0 pin 21 not connected
[    3.420000]  apic 0 pin 22 not connected
[    3.420000]  apic 0 pin 23 not connected
[    3.420000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    3.526959] ------------[ cut here ]------------
[    3.528640] WARNING: CPU: 0 PID: 1 at kernel/locking/lockdep.c:2760 trace_hardirqs_off_caller+0x108/0x120
[    3.530745] DEBUG_LOCKS_WARN_ON(!irqs_disabled())
[    3.532013] Modules linked in:
[    3.533837] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.9.0-rc6-00134-gb1e955c #1
[    3.534833] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[    3.537411]  ffffc9000000bcc8 ffffffff8144e9e3 ffffffff8113d618 ffffc9000000bd28
[    3.539432]  ffffc9000000bd28 0000000000000000 ffffc9000000bd18 ffffffff810ac222
[    3.540000]  0000000000000000 00000ac800000001 0000000000000000 00000000ffff8c25
[    3.540000] Call Trace:
[    3.540000]  [<ffffffff8144e9e3>] dump_stack+0xf1/0x16e
[    3.540000]  [<ffffffff8113d618>] ? trace_hardirqs_off_caller+0x108/0x120
[    3.540000]  [<ffffffff810ac222>] __warn+0x172/0x1a0
[    3.540000]  [<ffffffff810ac361>] warn_slowpath_fmt+0x61/0x80
[    3.540000]  [<ffffffff814644d0>] ? delay_tsc+0x1a0/0x1d0
[    3.540000]  [<ffffffff8113d618>] trace_hardirqs_off_caller+0x108/0x120
[    3.540000]  [<ffffffff8113d64d>] trace_hardirqs_off+0x1d/0x30
[    3.540000]  [<ffffffff82636855>] timer_irq_works+0x9f/0x10f
[    3.540000]  [<ffffffff82636f58>] setup_IO_APIC+0x693/0xee5
[    3.540000]  [<ffffffff81b6cb91>] ? _raw_spin_unlock_irqrestore+0x91/0xf0
[    3.540000]  [<ffffffff81054d43>] ? clear_IO_APIC_pin+0xe3/0x1a0
[    3.540000]  [<ffffffff82634398>] apic_bsp_setup+0x105/0x122
[    3.540000]  [<ffffffff82633422>] native_smp_prepare_cpus+0x4b3/0x55e
[    3.540000]  [<ffffffff8261fbfd>] kernel_init_freeable+0x76/0x2c4
[    3.540000]  [<ffffffff81b54e10>] ? rest_init+0x220/0x220
[    3.540000]  [<ffffffff81b54e26>] kernel_init+0x16/0x1d0
[    3.540000]  [<ffffffff81b6cfaa>] ret_from_fork+0x2a/0x40
[    3.543531] ---[ end trace 14a0f48288b7a69f ]---
[    3.544895] Using local APIC timer interrupts.
[    3.544895] calibrating APIC timer ...
[    3.560000] ... lapic delta = 6248563
[    3.560000] ... PM-Timer delta = 357866
[    3.560000] ... PM-Timer result ok
[    3.560000] ..... delta 6248563
[    3.560000] ..... mult: 268373737
[    3.560000] ..... calibration result: 9997700
[    3.560000] ..... CPU clock speed is 3199.2141 MHz.
[    3.560000] ..... host bus clock speed is 999.7700 MHz.
[    3.560000] smpboot: CPU0: AMD QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[    3.560000] Performance Events: PMU not available due to virtualization, using software events only.
[    3.773317] x86: Booted up 1 node, 1 CPUs
[    3.775170] smpboot: Total of 1 processors activated (6399.72 BogoMIPS)
[    3.857315] devtmpfs: initialized
[    3.900574] x86/mm: Memory block size: 128MB
[    4.144966] gcov: version magic: 0x3430342a
[    4.355329] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[    4.413605] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    4.447489] regulator-dummy: no parameters
[    4.492749] NET: Registered protocol family 16
[    4.624165] cpuidle: using governor menu
[    4.644114] ACPI: bus type PCI registered
[    4.648445] dca service started, version 1.12.1
[    4.655193] PCI: Using configuration type 1 for base access
[    5.576423] ACPI: Added _OSI(Module Device)
[    5.577612] ACPI: Added _OSI(Processor Device)
[    5.578456] ACPI: Added _OSI(3.0 _SCP Extensions)
[    5.579466] ACPI: Added _OSI(Processor Aggregator Device)
[    5.841627] ACPI: Interpreter enabled
[    5.843966] ACPI: (supports S0 S5)
[    5.844740] ACPI: Using IOAPIC for interrupt routing
[    5.852878] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    7.087089] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    7.091552] acpi PNP0A03:00: _OSC: OS supports [Segments]
[    7.094853] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    7.125993] PCI host bridge to bus 0000:00
[    7.127908] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    7.129262] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    7.130823] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    7.132248] pci_bus 0000:00: root bus resource [mem 0x14000000-0xfebfffff window]
[    7.134209] pci_bus 0000:00: root bus resource [bus 00-ff]
[    7.141666] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    7.201997] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    7.244505] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    7.263670] pci 0000:00:01.1: reg 0x20: [io  0xc040-0xc04f]
[    7.273800] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    7.275395] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    7.276865] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    7.278134] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    7.307891] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    7.312108] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    7.313108] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    7.341393] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    7.347592] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    7.356779] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    7.374531] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    7.401108] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    7.405430] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    7.409399] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    7.437319] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    7.476767] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000
[    7.480585] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f]
[    7.516310] pci_bus 0000:00: on NUMA node 0
[    7.615624] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    7.632771] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    7.644425] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    7.658042] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    7.672701] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    7.707097] ACPI: Enabled 3 GPEs in block 00 to 0F
[    7.825982] ACPI: bus type USB registered
[    7.834692] usbcore: registered new interface driver usbfs
[    7.837877] usbcore: registered new interface driver hub
[    7.842389] usbcore: registered new device driver usb
[    7.848192] pps_core: LinuxPPS API ver. 1 registered
[    7.848862] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    7.851279] PTP clock support registered
[    7.853362] EDAC MC: Ver: 3.0.0
[    7.861176] EDAC DEBUG: edac_mc_sysfs_init: device mc created
[    7.888753] FPGA manager framework
[    7.891119] PCI: Using ACPI for IRQ routing
[    7.892153] PCI: pci_cache_line_size set to 64 bytes
[    7.894639] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    7.896203] e820: reserve RAM buffer [mem 0x13fe0000-0x13ffffff]
[    8.008012] clocksource: Switched to clocksource hpet
[    8.127342] Warning: could not register annotated branches stats
[   11.108215] VFS: Disk quotas dquot_6.6.0
[   11.113141] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[   11.129076] FS-Cache: Loaded
[   11.143850] pnp: PnP ACPI init
[   11.172020] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[   11.187345] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[   11.202804] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[   11.207505] pnp 00:03: [dma 2]
[   11.217715] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[   11.236475] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[   11.255004] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[   11.273295] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[   11.336479] pnp: PnP ACPI: found 7 devices
[   11.499670] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[   11.525636] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[   11.526998] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[   11.528060] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[   11.529165] pci_bus 0000:00: resource 7 [mem 0x14000000-0xfebfffff window]
[   11.545107] NET: Registered protocol family 1
[   11.548161] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[   11.549708] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[   11.553045] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[   11.555479] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[   11.557503] PCI: CLS 0 bytes, default 64
[   11.615205] Unpacking initramfs...
[   99.995187] Freeing initrd memory: 13160K (ffff880013306000 - ffff880013fe0000)
[  100.172298] PCLMULQDQ-NI instructions are not detected.
[  100.184632] AVX or AES-NI instructions are not detected.
[  100.185981] CPU feature 'AVX registers' is not supported.
[  100.186955] AVX2 or AES-NI instructions are not detected.
[  100.198735] spin_lock-torture:--- Start of test [debug]: nwriters_stress=2 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[  100.204304] spin_lock-torture: Creating torture_shuffle task
[  100.212953] spin_lock-torture: torture_shuffle task started
[  100.215131] spin_lock-torture: Creating torture_stutter task
[  100.224379] spin_lock-torture: Creating lock_torture_writer task
[  100.229412] spin_lock-torture: torture_stutter task started
[  100.234954] spin_lock-torture: lock_torture_writer task started
[  100.235935] spin_lock-torture: Creating lock_torture_writer task
[  100.244603] spin_lock-torture: Creating lock_torture_stats task
[  100.248650] spin_lock-torture: lock_torture_writer task started
[  100.257215] spin_lock-torture: lock_torture_stats task started
[  100.259447] torture_init_begin: Refusing rcu init: spin_lock running.
[  100.261762] torture_init_begin: One torture test at a time!
[  100.263012] livepatch: Your compiler is too old; turning off.
[  100.336706] futex hash table entries: 256 (order: 3, 32768 bytes)
[  101.046017] tsc: Refined TSC clocksource calibration: 3199.996 MHz
[  101.047650] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2e20460fd56, max_idle_ns: 440795299145 ns
[  102.076581] clocksource: Switched to clocksource tsc
[  128.318386] Initialise system trusted keyrings
[  128.346737] workingset: timestamp_bits=62 max_order=17 bucket_order=0
[  129.195174] NET: Registered protocol family 38
[  129.197470] Key type asymmetric registered
[  129.198601] Asymmetric key parser 'x509' registered
[  129.199698] test_string_helpers: Running tests...
[  129.472785] test_hash: __hash_32() has no arch implementation to test.
[  129.474230] test_hash: hash_32() has no arch implementation to test.
[  129.475328] test_hash: hash_64() has no arch implementation to test.
[  129.476449] test_hash: 33152 tests passed.
[  131.558467] test_bitmap: all 460506 tests passed
[  131.576814] crc32: CRC_LE_BITS = 8, CRC_BE BITS = 8
[  131.577922] crc32: self tests passed, processed 225944 bytes in 7499752 nsec
[  131.587607] crc32c: CRC_LE_BITS = 8
[  131.588503] crc32c: self tests passed, processed 225944 bytes in 3675661 nsec
[  132.155517] crc32_combine: 8373 self tests passed
[  132.702742] crc32c_combine: 8373 self tests passed
[  132.743090] gpio_it87: no device
[  132.818698] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[  132.822325] ACPI: Power Button [PWRF]
[  132.937798] ioatdma: Intel(R) QuickData Technology Driver 4.00
[  141.416083] HDLC line discipline maxframe=4096
[  141.417248] N_HDLC line discipline registered.
[  141.418236] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[  141.477406] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[  141.553841] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[  141.685697] Initializing Nozomi driver 2.1d
[  141.726163] Non-volatile memory driver v1.3
[  141.743761] Linux agpgart interface v0.103
[  141.839083] Failed to find cpu0 device node
[  141.842219] Unable to detect cache hierarchy from DT for CPU 0
[  141.884636] Guest personality initialized and is inactive
[  141.902834] VMCI host device registered (name=vmci, major=10, minor=62)
[  141.904353] Initialized host personality
[  141.936770] usbcore: registered new interface driver rtsx_usb
[  142.023984] usbcore: registered new interface driver dln2
[  142.128989] libphy: Fixed MDIO Bus: probed
[  142.172756] arcnet: arcnet loaded
[  142.173799] arcnet:rfc1051: RFC1051 "simple standard" (`s') encapsulation support loaded
[  142.176218] arcnet:com90xx: COM90xx chipset support
[  142.537391] S3: No ARCnet cards found.
[  142.543503] arcnet:com90io: COM90xx IO-mapped mode support (by David Woodhouse et el.)
[  142.545073] arcnet:com90io: E-mail me if you actually test this driver, please!
[  142.546933] (unnamed net_device) (uninitialized): No autoprobe for IO mapped cards; you must specify the base address!
[  142.554948] arcnet:arc_rimi: RIM I (entirely mem-mapped) support
[  142.556284] arcnet:arc_rimi: E-mail me if you actually test the RIM I driver, please!
[  142.557580] arcnet:arc_rimi: Given: node 00h, shmem 0h, irq 0
[  142.558695] arcnet:arc_rimi: No autoprobe for RIM I; you must specify the shmem and irq!
[  142.565589] slcan: serial line CAN interface driver
[  142.566808] slcan: 10 dynamic interface channels.
[  142.608813] thunder-xcv, ver 1.0
[  142.615458] thunder-BGX, ver 1.0
[  142.623506] thunder-nic, ver 1.0
[  142.643702] v1.01-e (2.4 port) Sep-11-2006  Donald Becker <becker@scyld.com>
[  142.643702]   http://www.scyld.com/network/drivers.html
[  142.656304] vxge: Copyright(c) 2002-2010 Exar Corp.
[  142.657394] vxge: Driver version: 2.5.3.22640-k
[  142.663703] i40e: Intel(R) Ethernet Connection XL710 Network Driver - version 1.6.16-k
[  142.665198] i40e: Copyright (c) 2013 - 2014 Intel Corporation.
[  142.713788] jme: JMicron JMC2XX ethernet driver version 1.0.8
[  142.723358] sky2: driver version 1.30
[  142.749696] PPP generic driver version 2.4.2
[  142.785654] NET: Registered protocol family 24
[  142.789787] hdlc: HDLC support module revision 1.22
[  142.807598] DLCI driver v0.35, 4 Jan 1997, mike.mclagan@linux.org.
[  142.899312] uhci_hcd: USB Universal Host Controller Interface driver
[  142.908550] fotg210_hcd: FOTG210 Host Controller (EHCI) Driver
[  142.909831] Warning! fotg210_hcd should always be loaded before uhci_hcd and ohci_hcd, not after
[  142.936715] usbcore: registered new interface driver usblp
[  142.943445] usbcore: registered new interface driver cytherm
[  142.949742] usbcore: registered new interface driver emi62 - firmware loader
[  142.957739] usbcore: registered new interface driver usblcd
[  142.965821] usbcore: registered new interface driver ldusb
[  142.973813] usbcore: registered new interface driver rio500
[  142.978756] usbcore: registered new interface driver usb_ehset_test
[  142.985347] usbcore: registered new interface driver trancevibrator
[  142.995209] usbcore: registered new interface driver usbsevseg
[  143.016263] usbcore: registered new interface driver lvs
[  143.034836] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[  143.077992] serio: i8042 KBD port at 0x60,0x64 irq 1
[  143.092120] serio: i8042 AUX port at 0x60,0x64 irq 12
[  143.154093] usbcore: registered new interface driver bcm5974
[  143.207361] rtc_cmos 00:00: RTC can wake from S4
[  143.228444] rtc rtc0: alarm rollover: day
[  143.266496] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
[  143.285357] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
[  143.298502] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
[  143.438366] usbcore: registered new interface driver RobotFuzz Open Source InterFace, OSIF
[  143.446940] usbcore: registered new interface driver i2c-tiny-usb
[  143.469280] pps pps0: new PPS source ktimer
[  143.473095] pps pps0: ktimer PPS source registered
[  143.474427] pps_ldisc: PPS line discipline registered
[  143.664688] sch56xx_common: Unsupported device id: 0xff
[  143.666343] sch56xx_common: Unsupported device id: 0xff
[  143.725972] usbcore: registered new interface driver pcwd_usb
[  143.727321] acquirewdt: WDT driver for Acquire single board computer initialising
[  143.744602] acquirewdt: I/O address 0x0043 already in use
[  143.746510] acquirewdt: probe of acquirewdt failed with error -5
[  143.765365] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising
[  143.793253] wafer5823wdt: initialized. timeout=60 sec (nowayout=1)
[  143.798355] i6300esb: Intel 6300ESB WatchDog Timer Driver v0.05
[  143.807004] i6300esb: cannot register miscdev on minor=130 (err=-16)
[  143.812901] i6300ESB timer: probe of 0000:00:04.0 failed with error -16
[  143.818392] it87_wdt: no device
[  143.829449] sc1200wdt: build 20020303
[  143.836314] sc1200wdt: io parameter must be specified
[  143.843022] w83877f_wdt: I/O address 0x0443 already in use
[  143.844786] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16)
[  143.864863] watchdog: Software Watchdog: cannot register miscdev on minor=130 (err=-16).
[  143.866415] watchdog: Software Watchdog: a legacy watchdog module is probably present.
[  143.886233] softdog: initialized. soft_noboot=0 soft_margin=60 sec soft_panic=0 (nowayout=1)
[  143.887967] EDAC DEBUG: i5000_init: MC:
[  143.926449] EDAC DEBUG: i3200_init: i3200 pci_get_device fail
[  143.977059] VUB300 Driver rom wait states = 1C irqpoll timeout = 0400
[  144.050221] usbcore: registered new interface driver vub300
[  144.108737] ledtrig-cpu: registered to indicate activity on CPUs
[  144.288286] hidraw: raw HID events driver (C) Jiri Kosina
[  144.437971] usbcore: registered new interface driver usbhid
[  144.439290] usbhid: USB HID core driver
[  144.693063]  fake-fmc-carrier: mezzanine 0
[  144.695339]       Manufacturer: fake-vendor
[  144.696183]       Product name: fake-design-for-testing
[  144.709172] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[  144.715639] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95
[  144.721716] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[  144.749029] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001"
[  144.778392] oprofile: using NMI interrupt.
[  144.785763] NET: Registered protocol family 4
[  144.794771] can: controller area network core (rev 20120528 abi 9)
[  144.802546] NET: Registered protocol family 29
[  144.804063] can: broadcast manager protocol (rev 20160617 t)
[  144.806203] 8021q: 802.1Q VLAN Support v1.8
[  144.817175] 9pnet: Installing 9P2000 support
[  144.824434] NET: Registered protocol family 37
[  145.088906] ... APIC ID:      00000000 (0)
[  145.089808] ... APIC VERSION: 00050014
[  145.091084] 0000000000000000000000000000000000000000000000000000000000000000
[  145.092787] 0000000000000000000000000000000000000000000000000000000000000000
[  145.094202] 0000000000000000000000000000000000000000000000000000000000008000
[  145.104997] number of MP IRQ sources: 15.
[  145.105805] number of IO-APIC #0 registers: 24.
[  145.106574] testing the IO APIC.......................
[  145.115951] IO APIC #0......
[  145.116557] .... register #00: 00000000
[  145.117246] .......    : physical APIC id: 00
[  145.131503] .......    : Delivery Type: 0
[  145.132370] .......    : LTS          : 0
[  145.132727] .... register #01: 00170011
[  145.132727] .......     : max redirection entries: 17
[  145.140064] .......     : PRQ implemented: 0
[  145.140839] .......     : IO APIC version: 11
[  145.147289] .... register #02: 00000000
[  145.148062] .......     : arbitration: 00
[  145.148784] .... IRQ redirection table:
[  145.154531] IOAPIC 0:
[  145.155679]  pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.157187]  pin01, enabled , edge , high, V(31), IRR(0), S(0), logical , D(01), M(1)
[  145.158484]  pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(1)
[  145.159772]  pin03, disabled, edge , high, V(33), IRR(0), S(0), logical , D(01), M(1)
[  145.163369]  pin04, disabled, edge , high, V(34), IRR(0), S(0), logical , D(01), M(1)
[  145.164855]  pin05, disabled, level, high, V(35), IRR(0), S(0), logical , D(01), M(1)
[  145.166217]  pin06, enabled , edge , high, V(36), IRR(0), S(0), logical , D(01), M(1)
[  145.168041]  pin07, enabled , edge , high, V(37), IRR(0), S(0), logical , D(01), M(1)
[  145.169296]  pin08, enabled , edge , high, V(38), IRR(0), S(0), logical , D(01), M(1)
[  145.171994]  pin09, enabled , level, high, V(39), IRR(0), S(0), logical , D(01), M(1)
[  145.173400]  pin0a, disabled, level, high, V(3A), IRR(0), S(0), logical , D(01), M(1)
[  145.174760]  pin0b, disabled, level, high, V(3B), IRR(0), S(0), logical , D(01), M(1)
[  145.175779]  pin0c, enabled , edge , high, V(3C), IRR(0), S(0), logical , D(01), M(1)
[  145.177150]  pin0d, enabled , edge , high, V(3D), IRR(0), S(0), logical , D(01), M(1)
[  145.178469]  pin0e, enabled , edge , high, V(3E), IRR(0), S(0), logical , D(01), M(1)
[  145.179645]  pin0f, enabled , edge , high, V(3F), IRR(0), S(0), logical , D(01), M(1)
[  145.182423]  pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.183851]  pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.185170]  pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.186455]  pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.188664]  pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.189992]  pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.202926]  pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.204198]  pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[  145.205615] IRQ to pin mappings:
[  145.206634] IRQ0 -> 0:2
[  145.207662] IRQ1 -> 0:1
[  145.208360] IRQ3 -> 0:3
[  145.209061] IRQ4 -> 0:4
[  145.209710] IRQ5 -> 0:5
[  145.212281] IRQ6 -> 0:6
[  145.213004] IRQ7 -> 0:7
[  145.213678] IRQ8 -> 0:8
[  145.214364] IRQ9 -> 0:9
[  145.215066] IRQ10 -> 0:10
[  145.215773] IRQ11 -> 0:11
[  145.216500] IRQ12 -> 0:12
[  145.217227] IRQ13 -> 0:13
[  145.217941] IRQ14 -> 0:14
[  145.218637] IRQ15 -> 0:15
[  145.219412] .................................... done.
[  145.326219] registered taskstats version 1
[  145.342267] Loading compiled-in X.509 certificates
[  145.344390] page_owner is disabled
[  145.515653] Key type big_key registered
[  145.584632] Key type trusted registered
[  145.644277] Key type encrypted registered
[  146.259772] Freeing unused kernel memory: 3388K (ffffffff82447000 - ffffffff82796000)
[  146.263013] Write protecting the kernel read-only data: 18432k
[  146.316242] Freeing unused kernel memory: 556K (ffff880001b75000 - ffff880001c00000)
[  146.565372] Freeing unused kernel memory: 1644K (ffff880002065000 - ffff880002200000)
[  146.577900] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[  154.139921] init: Console is alive
[  154.194495] init: - watchdog -
[  155.316065] init: - preinit -
[  157.097435] procd: - early -
[  157.114151] procd: - watchdog -
[  161.765888] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  223.203329] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  224.533176] procd: - ubus -
[  226.357493] procd: - init -
Please press Enter to activate this console.
[  284.648465] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  346.100729] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  407.523481] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  468.977592] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  517.367114] Kernel tests: Boot OK!
LKP: HOSTNAME vm-lkp-os-openwrt-ia32-16, MAC , kernel 4.9.0-rc6-00134-gb1e955c 1, serial console /dev/ttyS0
[  523.766702] find: /opt/deb: No such file or directory
[  524.774128] find: /opt/deb: No such file or directory
[  526.795354] find: /opt/deb: No such file or directory
[  528.814549] find: /opt/deb: No such file or directory
[  530.407983] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  530.838623] find: /opt/deb: No such file or directory
[  532.894128] find: /opt/deb: No such file or directory
[  534.916326] find: /opt/deb: No such file or directory
[  535.925575] find: /opt/deb: No such file or directory
[  537.945372] find: /opt/deb: No such file or directory
[  538.954683] find: /opt/deb: No such file or directory
[  539.964066] find: /opt/deb: No such file or directory
[  540.975305] find: /opt/deb: No such file or directory
[  542.724099] LKP: waiting for network...
[  565.015479] /lkp/lkp/src/bin/run-lkp
[  577.430590] RESULT_ROOT=/result/trinity/300s/vm-lkp-os-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/0
[  577.430590] job=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml
[  581.563937] run-job /lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml
[  585.644001] skip http request: cgi-bin/lkp-jobfile-append-var?job_file=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml&job_state=running -O /dev/null
[  591.847097] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  606.854287] Seeding trinity based on x86_64-randconfig-s1-02070724
[  612.936742] 2017-02-08 11:43:31 trinity -q -q -l off -s 85657 -x get_robust_list -x remap_file_pages -N 999999999 -X
[  625.145915] Trinity v1.6-640-g37eaa4d  Dave Jones <davej@codemonkey.org.uk>
[  625.145915] Using getrandom() for seeds
[  625.145915] shm:0xf6dfc000-0x3468e64 (4 pages)
[  625.145915] [main] get_robust_list is NI_SYSCALL. Skipping
[  625.145915] [main] Marking syscall get_robust_list (312) as to be disabled.
[  625.145915] [main] Marking syscall remap_file_pages (257) as to be disabled.
[  625.204894] [main] Using user passed random seed: 85657
[  626.216072] [main] Kernel was tainted on startup. Will ignore flags that are already set.
[  626.216072] Marking all syscalls as enabled.
[  626.216072] [main] Disabling syscalls marked as disabled by command line options
[  626.216072] [main] Marked syscall remap_file_pages (257) as deactivated.
[  626.216072] [main] Marked syscall get_robust_list (312) as deactivated.
[  626.216072] [main] Enabled 377 syscalls. Disabled 3 syscalls.
[  627.277302] --dropprivs is still in development, and really shouldn't be used unless you're helping development. Expect crashes.
Going to run as user nobody (uid:1 gid:1)
ctrl-c now unless you really know what you are doing.
[  637.397310] [main] Using pid_max = 32768
[  637.397310] [main] There are 12 entries in the 0 list (@0x8b77bb0).
[  637.397310] [main]  start: 0xf6dde000 size:4KB  name: anon(PROT_READ | PROT_WRITE)
[  637.419208] [main]  start: 0xf6ddd000 size:4KB  name: anon(PROT_READ)
[  637.419208] [main]  start: 0xf6ddc000 size:4KB  name: anon(PROT_WRITE)
[  637.475500] [main]  start: 0xf6cdc000 size:1MB  name: anon(PROT_READ | PROT_WRITE)
[  637.475500] [main]  start: 0xf6bdc000 size:1MB  name: anon(PROT_READ)
[  637.475500] [main]  start: 0xf6adc000 size:1MB  name: anon(PROT_WRITE)
[  637.475500] [main]  start: 0xf68dc000 size:2MB  name: anon(PROT_READ | PROT_WRITE)
[  637.475500] [main]  start: 0xf66dc000 size:2MB  name: anon(PROT_READ)
[  637.475500] [main]  start: 0xf64dc000 size:2MB  name: anon(PROT_WRITE)
[  637.475500] [main]  start: 0xf64db000 size:4KB  name: anon(PROT_READ | PROT_WRITE)
[  637.475500] [main]  start: 0xf64da000 size:4KB  name: anon(PROT_READ)
[  637.475500] [main]  start: 0xf64d9000 size:4KB  name: anon(PROT_WRITE)
[  638.565163] [main] Reserved/initialized 5 futexes.
[  639.575758] [main] Added 282 filenames from /dev
[  653.285241] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  714.723864] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  776.166582] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  829.269790] [main] Added 8201 filenames from /proc
[  837.604359] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  899.045550] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  922.235236] kill 1111 
[  923.306032] cat /proc/kmsg 
[  924.364749] 
[  926.384337] wait for background monitors: 1113 1119 oom-killer nfs-hang
[  940.965683] sh: bad number
[  943.995911] sh: bad number
[  959.715076] skip http request: cgi-bin/lkp-jobfile-append-var?job_file=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml&loadavg=3.64 3.79 2.48 3/67 1661&start_time=1486554197&end_time=1486554515&version=/lkp/lkp/.src-20170207-172705& -O /dev/null
[  960.484205] Writes:  Total: 2  Max/Min: 0/0   Fail: 0 
[  963.756460] skip http request: cgi-bin/lkp-jobfile-append-var?job_file=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml&job_state=finished -O /dev/null
[  968.975449] LKP: rebooting
[  970.316999] sysrq: SysRq : Emergency Sync
[  970.346998] Emergency Sync complete
[  970.369974] sysrq: SysRq : Resetting

Elapsed time: 970

initrds=(
	/osimage/openwrt/openwrt-i386-2016-03-16.cgz
	/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.cgz
	/lkp/lkp/lkp-i386.cgz
	/osimage/pkg/static/trinity-i386.cgz
	/pkg/linux/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/modules.cgz
)

cat "${initrds[@]}" > /fs/sdb1/initrd-vm-lkp-os-openwrt-ia32-16

kvm=(
	qemu-system-x86_64
	-kernel /pkg/linux/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/vmlinuz-4.9.0-rc6-00134-gb1e955c
	-initrd /fs/sdb1/initrd-vm-lkp-os-openwrt-ia32-16
	-m 320
	-smp 1
	-device e1000,netdev=net0
	-netdev user,id=net0
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-pidfile /dev/shm/kboot/pid-vm-lkp-os-openwrt-ia32-16
	-serial file:/dev/shm/kboot/vm-lkp-os-openwrt-ia32-16/serial
	-serial file:/dev/shm/kboot/vm-lkp-os-openwrt-ia32-16/kmsg
	-daemonize
	-display none
	-monitor null
)

append=(
	ip=::::vm-lkp-os-openwrt-ia32-16::dhcp
	root=/dev/ram0
	user=lkp
	job=/lkp/scheduled/vm-lkp-os-openwrt-ia32-16/trinity-300s-openwrt-i386-2016-03-16.cgz-b1e955caea7e3ae340ebd5392a7fe4478f64ce1d-20170208-127980-1cei28s-0.yaml
	ARCH=x86_64
	kconfig=x86_64-randconfig-s1-02070724
	branch=linux-devel/devel-spot-201702070625
	commit=b1e955caea7e3ae340ebd5392a7fe4478f64ce1d
	BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/vmlinuz-4.9.0-rc6-00134-gb1e955c
	max_uptime=1500
	RESULT_ROOT=/result/trinity/300s/vm-lkp-os-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-s1-02070724/gcc-4.4/b1e955caea7e3ae340ebd5392a7fe4478f64ce1d/0
	LKP_SERVER=inn
	debug
	apic=debug
	sysrq_always_enabled
	rcupdate.rcu_cpu_stall_timeout=100
	net.ifnames=0
	printk.devkmsg=on
	panic=-1
	softlockup_panic=1
	nmi_watchdog=panic
	oops=panic
	load_ramdisk=2
	prompt_ramdisk=0
	systemd.log_level=err
	ignore_loglevel
	earlyprintk=ttyS0,115200
	console=ttyS0,115200
	console=tty0
	vga=normal
	rw
	drbd.minor_count=8
)

"${kvm[@]}" -append "${append[*]}"
