Re: [lockdep] b09be676e0 BUG: unable to handle kernel NULL pointer dereference at 000001f2

From: Fengguang Wu
Date: Mon Oct 09 2017 - 10:17:40 EST


On Mon, Oct 09, 2017 at 08:26:05AM -0500, Josh Poimboeuf wrote:
On Mon, Oct 09, 2017 at 08:55:04PM +0800, Fengguang Wu wrote:
On Mon, Oct 09, 2017 at 08:21:13PM +0800, Fengguang Wu wrote:
> On Mon, Oct 09, 2017 at 12:50:55PM +0200, Peter Zijlstra wrote:
> > > Fengguang, if you're still listening, could you please rerun the tests
> > > on top of ce07a9415f26, with the attached patches also applied?
> >
> > Ping!? it would be very good to get feedback on this asap.
>
> Sorry for the delay!
>
> > > From e7840ad76515f0b5061fcdd098b57b7c01b61482 Mon Sep 17 00:00:00 2001
> > > Message-Id: <e7840ad76515f0b5061fcdd098b57b7c01b61482.1507215196.git.jpoimboe@xxxxxxxxxx>
> > > From: Josh Poimboeuf <jpoimboe@xxxxxxxxxx>
> > > Date: Thu, 5 Oct 2017 09:43:59 -0500
> > > Subject: [PATCH 1/2] unwinder fixes
> > >
> > > ---
> > > arch/x86/kernel/unwind_frame.c | 33 ++++++++++++++++++++++++++++++---
>
> I just test 316 boots and see 7 WARNINGs:
>
> [ 404.948035] WARNING: kernel stack frame pointer at c6ea3ecd in init:212 has bad value (null)
> [ 298.118383] WARNING: kernel stack frame pointer at cde07dad in init:1 has bad value bc000000
> [ 112.848677] WARNING: kernel stack frame pointer at cde07dbd in swapper/0:1 has bad value c2000000
> [ 127.942417] WARNING: kernel stack frame pointer at cf95de71 in rb_producer:50 has bad value 03cf95de
> [ 4.736938] WARNING: kernel stack frame pointer at bf643d59 in kworker/0:1:15 has bad value b5000000
> [ 308.260066] WARNING: kernel stack frame pointer at bde07da5 in udevd:155 has bad value b5bfa17b
>
> [ 277.473596] WARNING: CPU: 0 PID: 520 at kernel/locking/lockdep.c:3841 check_flags+0x119/0x1b0

The unwinder patch I sent had a few bugs: it broke frame pointer
encoding (causing the '?' entries on the lockdep stack trace) and it
didn't disable the frame pointer warnings. Here's the fixed version.

Fengguang, can you do a round of tests with this patch and the lockdep
patch I sent before? Thanks!

It works! I tried 500 boots and only find 1 occurrence of this error,
which looks irrelevant to the current issue.

[ 187.855027] init: plymouth-splash main process (418) terminated with status 1
[ 187.953296] init: networking main process (419) terminated with status 1
[ 191.697721] ------------[ cut here ]------------
[ 191.699318] WARNING: CPU: 0 PID: 424 at kernel/locking/lockdep.c:3928 check_flags+0x119/0x1b0
[ 191.700967] CPU: 0 PID: 424 Comm: trinity-main Not tainted 4.14.0-rc3-00002-gc394639 #1
[ 191.702200] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 191.703476] task: c82fec80 task.stack: c8bbe000
[ 191.704194] EIP: check_flags+0x119/0x1b0
[ 191.704809] EFLAGS: 00010086 CPU: 0
[ 191.705380] EAX: 0000002e EBX: c82fec80 ECX: 00000107 EDX: b8afe274
[ 191.716483] ESI: c8003400 EDI: 00000000 EBP: c6de5c5c ESP: c6de5c54
[ 191.717457] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 191.718350] CR0: 80050033 CR2: 0858f014 CR3: 18035000 CR4: 00000690
[ 191.719405] Call Trace:
[ 191.719823] <SOFTIRQ>
[ 191.720241] lock_acquire+0x3d/0x230
[ 191.720819] ? perf_event_output_forward+0x14/0x180
[ 191.721601] ? __rcu_read_lock+0x3/0x20
[ 191.722218] perf_event_output_forward+0x41/0x180
[ 191.722958] ? perf_prepare_sample+0x830/0x830
[ 191.723657] ? __perf_event_account_interrupt+0x215/0x240
[ 191.724508] ? perf_prepare_sample+0x830/0x830
[ 191.725213] __perf_event_overflow+0x98/0x150
[ 191.725898] perf_swevent_overflow+0x9e/0xe0
[ 191.736679] perf_swevent_event+0x153/0x1a0
[ 191.737345] perf_tp_event+0x110/0x440
[ 191.737943] ? check_preemption_disabled+0x3d/0x1a0
[ 191.738759] ? check_preemption_disabled+0x3d/0x1a0
[ 191.739568] ? debug_smp_processor_id+0x12/0x20
[ 191.740332] ? perf_trace_buf_alloc+0xf9/0x1c0
[ 191.741107] perf_ftrace_function_call+0xe0/0xf0
[ 191.741866] ? __local_bh_enable+0x99/0xa0
[ 191.742586] ? ftrace_ops_no_ops+0x334/0x380
[ 191.743263] ftrace_ops_no_ops+0x334/0x380
[ 191.743924] ? check_preemption_disabled+0x3d/0x1a0
[ 191.744695] ? __local_bh_enable+0x99/0xa0
[ 191.745350] ? preempt_count_sub+0x8/0x2e0
[ 191.746000] ftrace_stub+0x14/0x1c
[ 191.756703] ? preempt_count_sub+0xd/0x2e0
[ 191.757404] ? trace_softirqs_on+0xf2/0x150
[ 191.758079] __local_bh_enable+0x99/0xa0
[ 191.758786] __do_softirq+0x6a5/0x9c0
[ 191.759440] ? __irqentry_text_end+0x6/0x6
[ 191.760096] do_softirq_own_stack+0x30/0x40
[ 191.760788] </SOFTIRQ>
[ 191.761230] irq_exit+0x56/0xd0
[ 191.761796] smp_apic_timer_interrupt+0x48d/0x6f0
[ 191.762571] apic_timer_interrupt+0x3a/0x40
[ 191.763298] EIP: lock_acquire+0x1d6/0x230
[ 191.763933] EFLAGS: 00000246 CPU: 0
[ 191.764548] EAX: 00000246 EBX: c82fec80 ECX: 6b96419b EDX: 00000000
[ 191.765567] ESI: 00000246 EDI: 00000000 EBP: c8bbfe64 ESP: c8bbfe30
[ 191.776469] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 191.777395] ? cgroup1_procs_write+0xb/0x20
[ 191.778068] ? handle_pte_fault+0x55f/0x1cc0
[ 191.778837] _raw_spin_lock+0x42/0x50
[ 191.779447] ? handle_pte_fault+0x55f/0x1cc0
[ 191.780119] handle_pte_fault+0x55f/0x1cc0
[ 191.780849] handle_mm_fault+0x531/0x700
[ 191.781504] ? handle_mm_fault+0x72/0x700
[ 191.782194] __do_page_fault+0xa8a/0xbd0
[ 191.782855] do_page_fault+0x2cc/0x422
[ 191.783471] ? kvm_read_and_reset_pf_reason+0x70/0x70
[ 191.784293] do_async_page_fault+0x26/0x60
[ 191.796340] common_exception+0x3d/0x42
[ 191.796973] EIP: 0xa7de393e
[ 191.797401] EFLAGS: 00010206 CPU: 0
[ 191.797924] EAX: 00000000 EBX: a7f0eff4 ECX: 00001ff1 EDX: 0858f010
[ 191.798902] ESI: 0858d008 EDI: 00002009 EBP: 00000004 ESP: afe7c120
[ 191.799828] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 191.800679] ? kvm_read_and_reset_pf_reason+0x70/0x70
[ 191.801453] Code: 00 85 c0 74 75 e8 88 8d 2f 00 85 c0 74 6c 83 3d cc c1 57 ba 00 75 63 c7 44 24 04 34 da 92 b9 c7 04 24 0a 93 91 b9 e8 ec 3b 01 00 <0f> ff eb 4b 8d 76 00 8b 0d 88 2a 54 ba 85 c9 75 3e 64 a1 4c 68
[ 191.804438] ---[ end trace 70000c51373576aa ]---
[ 191.805188] irq event stamp: 362178
[ 191.805708] hardirqs last enabled at (362176): [<b9490faa>] restore_all+0xf/0x25
[ 191.816989] hardirqs last disabled at (362177): [<b9496420>] __do_softirq+0xf0/0x9c0
[ 191.818122] softirqs last enabled at (362178): [<b94969d5>] __do_softirq+0x6a5/0x9c0
[ 191.819324] softirqs last disabled at (362171): [<b8a10ce0>] do_softirq_own_stack+0x30/0x40
[ 196.174500] init: tty4 main process ended, respawning
[ 196.249472] init: tty5 main process (375) terminated with status 1
[ 196.251170] init: tty5 main process ended, respawning
[ 196.270393] init: tty2 main process (377) terminated with status 1
[ 196.272059] init: tty2 main process ended, respawning
[ 196.428413] init: tty3 main process ended, respawning
[ 196.430660] init: tty6 main process (379) terminated with status 1
[ 196.437890] init: tty6 main process ended, respawning
[init] Using pid_max = 32768
[init] Kernel was tainted on startup. Will ignore flags that are already set.
[init] Started watchdog process, PID is 430
[main] Main thread is alive.
[main] Setsockopt(1 a 80d3000 7e) on fd 8 [1:1:1]
[main] Setsockopt(1 a 80d3000 13) on fd 11 [1:5:1]

Thanks,
Fengguang
early console in setup code
[ 0.000000] Linux version 4.14.0-rc3-00002-gc394639 (kbuild@lkp-snb01) (gcc version 4.8.4 (Debian 4.8.4-1)) #1 SMP PREEMPT Mon Oct 9 21:50:49 CST 2017
[ 0.000000] KERNEL supported cpus:
[ 0.000000] AMD AuthenticAMD
[ 0.000000] CPU: vendor_id 'GenuineIntel' unknown, using generic init.
[ 0.000000] CPU: Your system may be unstable.
[ 0.000000] x86/fpu: x87 FPU will use FXSAVE
[ 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-0x0000000018ed1fff] usable
[ 0.000000] BIOS-e820: [mem 0x0000000018ed2000-0x0000000018efffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[ 0.000000] debug: ignoring loglevel setting.
[ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000] random: fast init done
[ 0.000000] SMBIOS 2.8 present.
[ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 0.000000] Hypervisor detected: KVM
[ 0.000000] tsc: Fast TSC calibration failed
[ 0.000000] tsc: Unable to calibrate against PIT
[ 0.000000] tsc: No reference (HPET/PMTIMER) available
[ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.000000] e820: last_pfn = 0x18ed2 max_arch_pfn = 0x100000
[ 0.000000] MTRR default type: write-back
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 0080000000 mask FF80000000 uncachable
[ 0.000000] 1 disabled
[ 0.000000] 2 disabled
[ 0.000000] 3 disabled
[ 0.000000] 4 disabled
[ 0.000000] 5 disabled
[ 0.000000] 6 disabled
[ 0.000000] 7 disabled
[ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
[ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff]
[ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff]
[ 0.000000] found SMP MP-table at [mem 0x000f6a50-0x000f6a5f] mapped at [ffc67a50]
[ 0.000000] mpc: f6a60-f6b7c
[ 0.000000] initial memory mapped: [mem 0x00000000-0x0b7fffff]
[ 0.000000] Base memory trampoline at [b009b000] 9b000 size 16384
[ 0.000000] BRK [0x0b534000, 0x0b534fff] PGTABLE
[ 0.000000] RAMDISK: [mem 0x1768b000-0x18ecffff]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F6840 000014 (v00 BOCHS )
[ 0.000000] ACPI: RSDT 0x0000000018EE1628 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACP 0x0000000018EE147C 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.000000] ACPI: DSDT 0x0000000018EE0040 00143C (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACS 0x0000000018EE0000 000040
[ 0.000000] ACPI: APIC 0x0000000018EE1570 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.000000] ACPI: HPET 0x0000000018EE15F0 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] mapped APIC to ffffc000 ( fee00000)
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 398MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 18ed2000
[ 0.000000] low ram: 0 - 18ed2000
[ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000] kvm-clock: cpu 0, msr 0:18ed1001, primary cpu clock
[ 0.000000] kvm-clock: using sched offset of 898792862 cycles
[ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.000000] BRK [0x0b535000, 0x0b535fff] PGTABLE
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] Normal [mem 0x0000000001000000-0x0000000018ed1fff]
[ 0.000000] HighMem 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-0x0000000018ed1fff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000018ed1fff]
[ 0.000000] On node 0 totalpages: 102000
[ 0.000000] free_area_init_node: node 0, pgdat b9adda00, node_mem_map c72a3028
[ 0.000000] DMA zone: 40 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3998 pages, LIFO batch:0
[ 0.000000] Normal zone: 958 pages used for memmap
[ 0.000000] Normal zone: 98002 pages, LIFO batch:31
[ 0.000000] Using APIC driver default
[ 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 2 CPUs, 0 hotplug CPUs
[ 0.000000] mapped IOAPIC to ffffb000 (fec00000)
[ 0.000000] e820: [mem 0x18f00000-0xfeffbfff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on KVM
[ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] percpu: Embedded 19 pages/cpu @c727b000 s54528 r0 d23296 u77824
[ 0.000000] pcpu-alloc: s54528 r0 d23296 u77824 alloc=19*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] KVM setup async PF for cpu 0
[ 0.000000] kvm-stealtime: cpu 0, msr 1727dac0
[ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 101002
[ 0.000000] Kernel command line: root=/dev/ram0 hung_task_panic=1 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 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw link=/kbuild-tests/run-queue/kvm/i386-randconfig-i0-201739/wfg:unwind_frame-josh:c394639389261e631779eb1ac94aaf1d16f566a5/.vmlinuz-c394639389261e631779eb1ac94aaf1d16f566a5-20171009220139-265:quantal-vp-31 branch=wfg/unwind_frame-josh BOOT_IMAGE=/pkg/linux/i386-randconfig-i0-201739/gcc-4.8/c394639389261e631779eb1ac94aaf1d16f566a5/vmlinuz-4.14.0-rc3-00002-gc394639 drbd.minor_count=8
[ 0.000000] sysrq: sysrq always enabled.
[ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] allocated 412484 bytes of page_ext
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 333848K/408000K available (10845K kernel code, 3471K rwdata, 5544K rodata, 916K init, 23160K bss, 74152K reserved, 0K cma-reserved, 0K highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xffe66000 - 0xfffff000 (1636 kB)
[ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
[ 0.000000] vmalloc : 0xc96d2000 - 0xff7fe000 ( 865 MB)
[ 0.000000] lowmem : 0xb0000000 - 0xc8ed2000 ( 398 MB)
[ 0.000000] .init : 0xb9d7d000 - 0xb9e62000 ( 916 kB)
[ 0.000000] .data : 0xb949764c - 0xb9d66e40 (9021 kB)
[ 0.000000] .text : 0xb8a00000 - 0xb949764c (10845 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000]
[ 0.000000] **********************************************************
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] ** **
[ 0.000000] ** trace_printk() being used. Allocating extra memory. **
[ 0.000000] ** **
[ 0.000000] ** This means that this is a DEBUG kernel and it is **
[ 0.000000] ** unsafe for production use. **
[ 0.000000] ** **
[ 0.000000] ** If you see this message and you are not debugging **
[ 0.000000] ** the kernel, report this immediately to your vendor! **
[ 0.000000] ** **
[ 0.000000] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 0.000000] **********************************************************
[ 0.010000] Running RCU self tests
[ 0.010000] Preemptible hierarchical RCU implementation.
[ 0.010000] RCU lockdep checking is enabled.
[ 0.010000] RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[ 0.010000] RCU debug extended QS entry/exit.
[ 0.010000] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[ 0.010000] Tasks RCU enabled.
[ 0.010000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.010000] NR_IRQS: 2304, nr_irqs: 440, preallocated irqs: 16
[ 0.010000] CPU 0 irqstacks, hard=c6de2000 soft=c6de4000
[ 0.010000] console [ttyS0] enabled
[ 0.010000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.010000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.010000] ... MAX_LOCK_DEPTH: 48
[ 0.010000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.010000] ... CLASSHASH_SIZE: 4096
[ 0.010000] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.010000] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.010000] ... CHAINHASH_SIZE: 32768
[ 0.010000] memory used by lock dependency info: 4399 kB
[ 0.010000] per task-struct memory footprint: 1536 bytes
[ 0.010000] ------------------------
[ 0.010000] | Locking API testsuite:
[ 0.010000] ----------------------------------------------------------------------------
[ 0.010000] | spin |wlock |rlock |mutex | wsem | rsem |
[ 0.010000] --------------------------------------------------------------------------
[ 0.010000] A-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] double unlock: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] initialize held: ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] --------------------------------------------------------------------------
[ 0.010000] recursive read-lock: | ok | | ok |
[ 0.010000] recursive read-lock #2: | ok | | ok |
[ 0.010000] mixed read-write-lock: | ok | | ok |
[ 0.010000] mixed write-read-lock: | ok | | ok |
[ 0.010000] mixed read-lock/lock-write ABBA: |FAILED| | ok |
[ 0.010000] mixed read-lock/lock-read ABBA: | ok | | ok |
[ 0.010000] mixed write-lock/lock-write ABBA: | ok | | ok |
[ 0.010000] --------------------------------------------------------------------------
[ 0.010000] hard-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 0.010000] soft-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 0.010000] hard-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 0.010000] soft-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 0.010000] sirq-safe-A => hirqs-on/12: ok | ok | ok |
[ 0.010000] sirq-safe-A => hirqs-on/21: ok | ok | ok |
[ 0.010000] hard-safe-A + irqs-on/12: ok | ok | ok |
[ 0.010000] soft-safe-A + irqs-on/12: ok | ok | ok |
[ 0.010000] hard-safe-A + irqs-on/21: ok | ok | ok |
[ 0.010000] soft-safe-A + irqs-on/21: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 0.010000] hard-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 0.010000] soft-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/123: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/123: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/132: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/132: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/213: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/213: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/231: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/231: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/312: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/312: ok | ok | ok |
[ 0.010000] hard-irq lock-inversion/321: ok | ok | ok |
[ 0.010000] soft-irq lock-inversion/321: ok | ok | ok |
[ 0.010000] hard-irq read-recursion/123: ok |
[ 0.010000] soft-irq read-recursion/123: ok |
[ 0.010000] hard-irq read-recursion/132: ok |
[ 0.010000] soft-irq read-recursion/132: ok |
[ 0.010000] hard-irq read-recursion/213: ok |
[ 0.010000] soft-irq read-recursion/213: ok |
[ 0.010000] hard-irq read-recursion/231: ok |
[ 0.010000] soft-irq read-recursion/231: ok |
[ 0.010000] hard-irq read-recursion/312: ok |
[ 0.010000] soft-irq read-recursion/312: ok |
[ 0.010000] hard-irq read-recursion/321: ok |
[ 0.010000] soft-irq read-recursion/321: ok |
[ 0.010000] --------------------------------------------------------------------------
[ 0.010000] | Wound/wait tests |
[ 0.010000] ---------------------
[ 0.010000] ww api failures: ok | ok | ok |
[ 0.010000] ww contexts mixing: ok | ok |
[ 0.010000] finishing ww context: ok | ok | ok | ok |
[ 0.010000] locking mismatches: ok | ok | ok |
[ 0.010000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |
[ 0.010000] spinlock nest unlocked: ok |
[ 0.010000] -----------------------------------------------------
[ 0.010000] |block | try |context|
[ 0.010000] -----------------------------------------------------
[ 0.010000] context: ok | ok | ok |
[ 0.010000] try: ok | ok | ok |
[ 0.010000] block: ok | ok | ok |
[ 0.010000] spinlock: ok | ok | ok |
[ 0.010000] -------------------------------------------------------
[ 0.010000] Good, all 261 testcases passed! |
[ 0.010000] ---------------------------------
[ 0.010000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 0.010000] hpet clockevent registered
[ 0.010031] tsc: Detected 2693.508 MHz processor
[ 0.010718] tsc: Marking TSC unstable due to TSCs unsynchronized
[ 0.010877] Calibrating delay loop (skipped) preset value.. 5387.01 BogoMIPS (lpj=26935080)
[ 0.012096] pid_max: default: 32768 minimum: 301
[ 0.012844] ACPI: Core revision 20170728
[ 0.021645] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 0.023295] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.024294] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.030486] mce: CPU supports 10 MCE banks
[ 0.031131] mce: unknown CPU type - not enabling MCE support
[ 0.031972] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.032774] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.033947] Freeing SMP alternatives memory: 20K
[ 0.036401] smpboot: Max logical packages: 2
[ 0.037086] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.037952] enabled ExtINT on CPU#0
[ 0.050475] ENABLING IO-APIC IRQs
[ 0.051107] init IO_APIC IRQs
[ 0.051623] apic 0 pin 0 not connected
[ 0.052309] IOAPIC[0]: Set routing entry (0-1 -> 0x31 -> IRQ 1 Mode:0 Active:0 Dest:1)
[ 0.053583] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1)
[ 0.054827] IOAPIC[0]: Set routing entry (0-3 -> 0x33 -> IRQ 3 Mode:0 Active:0 Dest:1)
[ 0.056073] IOAPIC[0]: Set routing entry (0-4 -> 0x34 -> IRQ 4 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-5 -> 0x35 -> IRQ 5 Mode:1 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-6 -> 0x36 -> IRQ 6 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-7 -> 0x37 -> IRQ 7 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-8 -> 0x38 -> IRQ 8 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-9 -> 0x39 -> IRQ 9 Mode:1 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-10 -> 0x3a -> IRQ 10 Mode:1 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-11 -> 0x3b -> IRQ 11 Mode:1 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-12 -> 0x3c -> IRQ 12 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-13 -> 0x3d -> IRQ 13 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-14 -> 0x3e -> IRQ 14 Mode:0 Active:0 Dest:1)
[ 0.060000] IOAPIC[0]: Set routing entry (0-15 -> 0x3f -> IRQ 15 Mode:0 Active:0 Dest:1)
[ 0.060000] apic 0 pin 16 not connected
[ 0.060000] apic 0 pin 17 not connected
[ 0.060000] apic 0 pin 18 not connected
[ 0.060000] apic 0 pin 19 not connected
[ 0.060000] apic 0 pin 20 not connected
[ 0.060000] apic 0 pin 21 not connected
[ 0.060000] apic 0 pin 22 not connected
[ 0.060000] apic 0 pin 23 not connected
[ 0.060000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.060000] Using local APIC timer interrupts.
[ 0.060000] calibrating APIC timer ...
[ 0.070000] ... lapic delta = 8750957
[ 0.070000] ... PM-Timer delta = 501212
[ 0.070000] APIC calibration not consistent with PM-Timer: 140ms instead of 100ms
[ 0.070000] APIC delta adjusted to PM-Timer: 6249730 (8750957)
[ 0.070000] TSC delta adjusted to PM-Timer: 269350330 (377147952)
[ 0.070000] ..... delta 6249730
[ 0.070000] ..... mult: 268423859
[ 0.070000] ..... calibration result: 9999568
[ 0.070000] ..... CPU clock speed is 2693.5033 MHz.
[ 0.070000] ..... host bus clock speed is 999.9568 MHz.
[ 0.070096] smpboot: CPU0: GenuineIntel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
[ 0.110092] Performance Events: no PMU driver, software events only.
[ 0.130052] Hierarchical SRCU implementation.
[ 0.190048] smp: Bringing up secondary CPUs ...
[ 0.272220] CPU 1 irqstacks, hard=c6ff4000 soft=c6ff6000
[ 0.273039] x86: Booting SMP configuration:
[ 0.273659] .... node #0, CPUs: #1
[ 0.000000] Initializing CPU#1
[ 0.010000] kvm-clock: cpu 1, msr 0:18ed1041, secondary cpu clock
[ 0.010000] masked ExtINT on CPU#1
[ 0.310122] KVM setup async PF for cpu 1
[ 0.310122] kvm-stealtime: cpu 1, msr 17290ac0
[ 0.312433] smp: Brought up 1 node, 2 CPUs
[ 0.320023] smpboot: Total of 2 processors activated (10774.03 BogoMIPS)
[ 0.350033] devtmpfs: initialized
[ 0.357934] workqueue: round-robin CPU selection forced, expect performance impact
[ 0.380667] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.382330] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.385324] prandom: seed boundary self test passed
[ 0.390522] prandom: 100 self tests passed
[ 0.391872] regulator-dummy: no parameters
[ 0.395709] NET: Registered protocol family 16
[ 0.410037] cpuidle: using governor ladder
[ 0.411844] ACPI: bus type PCI registered
[ 0.413200] PCI: PCI BIOS revision 2.10 entry at 0xfd501, last bus=0
[ 0.420035] PCI: Using configuration type 1 for base access
[ 0.510380] HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages
[ 0.520395] gpio-f7188x: Not a Fintek device at 0x0000002e
[ 0.521291] gpio-f7188x: Not a Fintek device at 0x0000004e
[ 0.522849] ACPI: Added _OSI(Module Device)
[ 0.523504] ACPI: Added _OSI(Processor Device)
[ 0.530089] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.530950] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.588050] ACPI: Interpreter enabled
[ 0.588669] ACPI: (supports S0 S5)
[ 0.589198] ACPI: Using IOAPIC for interrupt routing
[ 0.590185] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.593514] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 0.754281] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.760045] acpi PNP0A03:00: _OSC: OS supports [Segments]
[ 0.770142] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.773668] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.775893] PCI host bridge to bus 0000:00
[ 0.780042] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.781170] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.782282] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.783506] pci_bus 0000:00: root bus resource [mem 0x18f00000-0xfebfffff window]
[ 0.784732] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.785780] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 0.791358] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 0.795209] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 0.830027] pci 0000:00:01.1: reg 0x20: [io 0xc200-0xc20f]
[ 0.843432] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.844452] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.845398] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.846421] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.860385] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 0.862094] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 0.863145] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 0.866132] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 0.873566] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 0.893739] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[ 0.940033] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 0.942803] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 0.950026] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 0.957807] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 0.996422] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 1.010712] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
[ 1.020026] pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f]
[ 1.030027] pci 0000:00:04.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[ 1.064341] pci 0000:00:04.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[ 1.076833] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
[ 1.100025] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf]
[ 1.110027] pci 0000:00:05.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff]
[ 1.164755] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
[ 1.182575] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
[ 1.194711] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff]
[ 1.204773] pci 0000:00:06.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff]
[ 1.240030] pci 0000:00:06.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref]
[ 1.262557] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
[ 1.290023] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f]
[ 1.304797] pci 0000:00:07.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff]
[ 1.334681] pci 0000:00:07.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref]
[ 1.352467] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000
[ 1.364707] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f]
[ 1.390030] pci 0000:00:08.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff]
[ 1.450026] pci 0000:00:08.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref]
[ 1.481479] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000
[ 1.494616] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf]
[ 1.504472] pci 0000:00:09.0: reg 0x14: [mem 0xfebf6000-0xfebf6fff]
[ 1.540028] pci 0000:00:09.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref]
[ 1.552538] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000
[ 1.570044] pci 0000:00:0a.0: reg 0x10: [io 0xc1c0-0xc1ff]
[ 1.590033] pci 0000:00:0a.0: reg 0x14: [mem 0xfebf7000-0xfebf7fff]
[ 1.620026] pci 0000:00:0a.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref]
[ 1.640551] pci 0000:00:0b.0: [8086:25ab] type 00 class 0x088000
[ 1.653542] pci 0000:00:0b.0: reg 0x10: [mem 0xfebf8000-0xfebf800f]
[ 1.687035] pci_bus 0000:00: on NUMA node 0
[ 1.696958] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[ 1.698708] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[ 1.700458] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[ 1.710964] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[ 1.712290] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[ 1.730189] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[ 1.731085] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 1.732340] pci 0000:00:02.0: vgaarb: bridge control possible
[ 1.733178] vgaarb: loaded
[ 1.735566] ACPI: bus type USB registered
[ 1.736337] usbcore: registered new interface driver usbfs
[ 1.737256] usbcore: registered new interface driver hub
[ 1.740183] usbcore: registered new device driver usb
[ 1.741485] pps_core: LinuxPPS API ver. 1 registered
[ 1.742215] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@xxxxxxxx>
[ 1.750105] EDAC MC: Ver: 3.0.0
[ 1.751317] EDAC DEBUG: edac_mc_sysfs_init: device mc created
[ 1.760406] Unable to find dmi tokens
[ 1.770424] FPGA manager framework
[ 1.771085] PCI: Using ACPI for IRQ routing
[ 1.771701] PCI: pci_cache_line_size set to 64 bytes
[ 1.772835] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 1.773718] e820: reserve RAM buffer [mem 0x18ed2000-0x1bffffff]
[ 1.806737] clocksource: Switched to clocksource kvm-clock
[ 1.807092] Warning: could not register all branches stats
[ 1.807951] Warning: could not register annotated branches stats
[ 2.345637] VFS: Disk quotas dquot_6.6.0
[ 2.346357] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 2.347704] FS-Cache: Loaded
[ 2.348454] pnp: PnP ACPI init
[ 2.349460] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 2.350751] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[ 2.352053] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 2.373269] pnp 00:03: [dma 2]
[ 2.374007] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[ 2.375596] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[ 2.377054] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[ 2.378441] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[ 2.381941] pnp: PnP ACPI: found 7 devices
[ 2.440399] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 2.442025] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 2.442892] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
[ 2.461872] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[ 2.462867] pci_bus 0000:00: resource 7 [mem 0x18f00000-0xfebfffff window]
[ 2.475098] NET: Registered protocol family 1
[ 2.475808] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 2.476690] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 2.477581] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 2.478575] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 2.479942] PCI: CLS 0 bytes, default 64
[ 2.481151] Unpacking initramfs...
[ 9.135198] Freeing initrd memory: 24852K
[ 9.138641] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns
[ 9.140394] Machine check injector initialized
[ 9.166989] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[ 9.168303] NatSemi SCx200 Driver
[ 9.169058] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0
[ 9.171555] spin_lock-torture: Creating torture_shuffle task
[ 9.184266] spin_lock-torture: Creating torture_stutter task
[ 9.185131] spin_lock-torture: torture_shuffle task started
[ 9.186151] spin_lock-torture: Creating lock_torture_writer task
[ 9.187157] spin_lock-torture: torture_stutter task started
[ 9.188051] spin_lock-torture: Creating lock_torture_writer task
[ 9.189072] spin_lock-torture: lock_torture_writer task started
[ 9.190163] spin_lock-torture: Creating lock_torture_writer task
[ 9.191231] spin_lock-torture: lock_torture_writer task started
[ 9.193124] spin_lock-torture: Creating lock_torture_writer task
[ 9.194066] spin_lock-torture: lock_torture_writer task started
[ 9.198148] spin_lock-torture: lock_torture_writer task started
[ 9.199036] spin_lock-torture: Creating lock_torture_stats task
[ 9.213132] spin_lock-torture: lock_torture_stats task started
[ 9.226288] Key type blacklist registered
[ 9.236130] workingset: timestamp_bits=14 max_order=17 bucket_order=3
[ 9.371983] zbud: loaded
[ 9.400049] orangefs_debugfs_init: called with debug mask: :none: :0:
[ 9.401476] orangefs_init: module version upstream loaded
[ 10.604214] Key type asymmetric registered
[ 10.604948] test_string_helpers: Running tests...
[ 10.610704] test_hexdump: all 1184 tests passed
[ 10.611955] test_firmware: interface ready
[ 10.717089] test_hash: __hash_32() has no arch implementation to test.
[ 10.718069] test_hash: hash_32() has no arch implementation to test.
[ 10.719108] test_hash: hash_64() has no arch implementation to test.
[ 10.720151] test_hash: 33152 tests passed.
[ 10.720878] test_siphash: self-tests: pass
[ 10.743955] Running rhashtable test nelem=8, max_size=0, shrinking=0
[ 10.745058] Test 00:
[ 10.753520] Adding 50000 keys
[ 12.195791] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 12.761685] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 12.762834] Deleting 50000 keys
[ 13.468828] Duration of test: 2708039140 ns
[ 13.471546] Test 01:
[ 13.491538] Adding 50000 keys
[ 15.061599] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 15.560729] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 15.561960] Deleting 50000 keys
[ 16.195359] Duration of test: 2703326222 ns
[ 16.196016] Test 02:
[ 16.197879] Adding 50000 keys
[ 17.790661] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 18.280039] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 18.298329] Deleting 50000 keys
[ 19.011160] Duration of test: 2812837736 ns
[ 19.011875] Test 03:
[ 19.020854] Adding 50000 keys
[ 20.678665] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 21.187815] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 21.200699] Deleting 50000 keys
[ 21.896142] Duration of test: 2874733313 ns
[ 21.898792] Average test time: 2774734102
[ 21.921558] Testing concurrent rhashtable access from 10 threads
[ 56.195918] Started 10 threads, 0 failed
[ 56.200578] test passed
[ 56.211937] test_printf: all 260 tests passed
[ 56.806002] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 2055
[ 56.862805] test_bitmap: all 460506 tests passed
[ 56.868877] crc32: CRC_LE_BITS = 1, CRC_BE BITS = 1
[ 56.869707] crc32: self tests passed, processed 225944 bytes in 2648766 nsec
[ 56.903856] crc32c: CRC_LE_BITS = 1
[ 56.904429] crc32c: self tests passed, processed 225944 bytes in 1393934 nsec
[ 57.411090] crc32_combine: 8373 self tests passed
[ 57.983198] crc32c_combine: 8373 self tests passed
[ 57.991522] atomic64_test: passed for i386+ platform with CX8 and with SSE
[ 57.992749] glob: 64 self-tests passed, 0 failed
[ 57.993509] interval tree insert/remove
[ 63.415540] -> 146042 cycles
[ 63.416472] interval tree search
[ 65.900057] -> 668947 cycles (2692 results)
[ 65.905003] no IO addresses supplied
[ 65.906106] usbcore: registered new interface driver udlfb
[ 65.907128] ipmi message handler version 39.2
[ 65.907865] IPMI System Interface driver.
[ 65.937114] ipmi_si: Unable to find any System Interface(s)
[ 65.938041] IPMI SSIF Interface driver
[ 65.938850] IPMI Watchdog: driver initialized
[ 65.939536] Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot.
[ 65.951940] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 65.953093] ACPI: Power Button [PWRF]
[ 66.667157] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 66.780577] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 66.860567] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[ 66.921164] lp: driver loaded but no devices found
[ 66.922355] Non-volatile memory driver v1.3
[ 66.940539] scx200_gpio: no SCx200 gpio present
[ 66.941646] platform pc8736x_gpio.0: NatSemi pc8736x GPIO Driver Initializing
[ 66.942696] platform pc8736x_gpio.0: no device found
[ 66.943725] nsc_gpio initializing
[ 66.944302] telclk_interrupt = 0xf non-mcpbl0010 hw.
[ 66.945102] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds).
[ 66.954099] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0xd2fa055a max_iterations=8192 max_prime=128
[ 66.955702] drm_mm: igt_sanitycheck - ok!
[ 81.530075] Writes: Total: 4 Max/Min: 0/0 Fail: 0
[ 146.140042] Writes: Total: 4 Max/Min: 0/0 Fail: 0
[ 178.999319] drm_mm: lookup failed for node 0 + 1
[ 179.005908] parport_pc 00:04: reported by Plug and Play ACPI
[ 179.030388] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
[ 179.032414] lp0: using parport0 (interrupt-driven).
[ 179.053014] dummy-irq: no IRQ given. Use irq=N
[ 179.055301] usbcore: registered new interface driver rtsx_usb
[ 179.058285] usbcore: registered new interface driver viperboard
[ 179.060787] parport0: cannot grant exclusive access for device spi-lm70llp
[ 179.080190] spi_lm70llp: spi_lm70llp probe fail, status -12
[ 179.082180] parport0: cannot grant exclusive access for device ks0108
[ 179.083287] ks0108: ERROR: parport didn't register new device
[ 179.084279] cfag12864b: ERROR: ks0108 is not initialized
[ 179.085199] cfag12864bfb: ERROR: cfag12864b is not initialized
[ 179.313224] panel: panel driver registered on parport0 (io=0x378).
[ 179.314445] usbcore: registered new interface driver hwa-rc
[ 179.315856] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 179.316876] ehci-pci: EHCI PCI platform driver
[ 179.317705] ehci-platform: EHCI generic platform driver
[ 179.318758] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 179.328839] ohci-pci: OHCI PCI platform driver
[ 179.329635] ohci-platform: OHCI generic platform driver
[ 179.330671] fotg210_hcd: FOTG210 Host Controller (EHCI) Driver
[ 179.331535] Warning! fotg210_hcd should always be loaded before uhci_hcd and ohci_hcd, not after
[ 179.340896] usbcore: registered new interface driver wusb-cbaf
[ 179.341832] usbcore: registered new interface driver cdc_wdm
[ 179.342748] usbcore: registered new interface driver mdc800
[ 179.343565] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera
[ 179.344823] usbcore: registered new interface driver adutux
[ 179.345759] usbcore: registered new interface driver appledisplay
[ 179.346800] usbcore: registered new interface driver cytherm
[ 179.347754] usbcore: registered new interface driver emi62 - firmware loader
[ 179.348819] ftdi_elan: driver ftdi-elan
[ 179.367661] usbcore: registered new interface driver ftdi-elan
[ 179.368591] usbcore: registered new interface driver iowarrior
[ 179.369512] usbcore: registered new interface driver isight_firmware
[ 179.370507] usbcore: registered new interface driver usblcd
[ 179.371403] usbcore: registered new interface driver ldusb
[ 179.372278] usbcore: registered new interface driver legousbtower
[ 179.373255] usbcore: registered new interface driver rio500
[ 179.374164] usbcore: registered new interface driver usbtest
[ 179.375136] usbcore: registered new interface driver usb_ehset_test
[ 179.394321] usbcore: registered new interface driver uss720
[ 179.395142] uss720: USB Parport Cable driver for Cables using the Lucent Technologies USS720 Chip
[ 179.396401] uss720: NOTE: this is a special purpose driver to allow nonstandard
[ 179.397469] uss720: protocols (eg. bitbang) over USS720 usb to parallel cables
[ 179.398506] uss720: If you just want to connect to a printer, use usblp instead
[ 179.399627] usbcore: registered new interface driver usbsevseg
[ 179.400568] usbcore: registered new interface driver yurex
[ 179.401723] usbcore: registered new interface driver sisusb
[ 179.402610] usbcore: registered new interface driver lvs
[ 179.415704] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 179.451570] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 179.452374] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 179.453337] parport0: cannot grant exclusive access for device parkbd
[ 179.675063] mousedev: PS/2 mouse device common for all mice
[ 179.675934] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0)
[ 179.677361] usbcore: registered new interface driver appletouch
[ 179.678308] usbcore: registered new interface driver bcm5974
[ 179.690019] usbcore: registered new interface driver xpad
[ 179.691039] usbcore: registered new interface driver gtco
[ 179.709735] usbcore: registered new interface driver hanwang
[ 179.710662] usbcore: registered new interface driver kbtab
[ 179.711560] usbcore: registered new interface driver pegasus_notetaker
[ 179.715700] i2c /dev entries driver
[ 179.716631] usbcore: registered new interface driver i2c-tiny-usb
[ 179.738712] pps pps0: new PPS source ktimer
[ 179.739388] pps pps0: ktimer PPS source registered
[ 179.740234] Driver for 1-wire Dallas network protocol.
[ 179.741333] usbcore: registered new interface driver DS9490R
[ 179.742208] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko
[ 179.743351] w1_f0d_init()
[ 179.765080] applesmc: supported laptop not found!
[ 179.765781] applesmc: driver init failed (ret=-19)!
[ 179.770094] pc87360: PC8736x not detected, module not inserted
[ 179.772369] sdhci: Secure Digital Host Controller Interface driver
[ 179.773323] sdhci: Copyright(c) Pierre Ossman
[ 179.792281] wbsd: Winbond W83L51xD SD/MMC card interface driver
[ 179.793151] wbsd: Copyright(c) Pierre Ossman
[ 179.794057] VUB300 Driver rom wait states = 1C irqpoll timeout = 0400
[ 179.864608] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 179.884130] usbcore: registered new interface driver vub300
[ 179.894866] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0)
[ 179.910298] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 179.922465] hidraw: raw HID events driver (C) Jiri Kosina
[ 179.926430] usbcore: registered new interface driver usbkbd
[ 179.927353] usbcore: registered new interface driver usbmouse
[ 179.948232] fake-fmc-carrier: mezzanine 0
[ 179.948891] Manufacturer: fake-vendor
[ 179.949545] Product name: fake-design-for-testing
[ 179.950632] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 179.951770] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95
[ 179.952977] fmc fake-design-for-testing-f001: Driver has no ID: matches all
[ 179.954021] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards
[ 179.983823] start plist test
[ 179.991564] end plist test
[ 179.992019] mce: Unable to init MCE device (rc: -5)
[ 179.993714] ... APIC ID: 00000000 (0)
[ 179.994327] ... APIC VERSION: 01050014
[ 179.994900] 0000000000000000000000000000000000000000000000000000000000000000
[ 179.996029] 0000000000000000000000000000000000000000000000000000000000000000
[ 179.997144] 0000000000000000000000000000000000000000000000000000000000008000
[ 180.007016] number of MP IRQ sources: 15.
[ 180.007609] number of IO-APIC #0 registers: 24.
[ 180.008305] testing the IO APIC.......................
[ 180.009120] IO APIC #0......
[ 180.009580] .... register #00: 00000000
[ 180.010182] ....... : physical APIC id: 00
[ 180.010849] ....... : Delivery Type: 0
[ 180.011475] ....... : LTS : 0
[ 180.012099] .... register #01: 00170011
[ 180.012695] ....... : max redirection entries: 17
[ 180.013469] ....... : PRQ implemented: 0
[ 180.014143] ....... : IO APIC version: 11
[ 180.014825] .... register #02: 00000000
[ 180.015428] ....... : arbitration: 00
[ 180.016051] .... IRQ redirection table:
[ 180.016659] IOAPIC 0:
[ 180.017077] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.018277] pin01, enabled , edge , high, V(31), IRR(0), S(0), logical , D(03), M(1)
[ 180.019476] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(03), M(1)
[ 180.033775] pin03, enabled , edge , high, V(33), IRR(0), S(0), logical , D(03), M(1)
[ 180.034991] pin04, enabled , edge , high, V(34), IRR(0), S(0), logical , D(03), M(1)
[ 180.036219] pin05, disabled, level, high, V(35), IRR(0), S(0), logical , D(03), M(1)
[ 180.037468] pin06, enabled , edge , high, V(36), IRR(0), S(0), logical , D(03), M(1)
[ 180.038671] pin07, enabled , edge , high, V(37), IRR(0), S(0), logical , D(03), M(1)
[ 180.039873] pin08, enabled , edge , high, V(38), IRR(0), S(0), logical , D(03), M(1)
[ 180.041075] pin09, enabled , level, high, V(39), IRR(0), S(0), logical , D(03), M(1)
[ 180.042341] pin0a, disabled, level, high, V(3A), IRR(0), S(0), logical , D(03), M(1)
[ 180.043536] pin0b, disabled, level, high, V(3B), IRR(0), S(0), logical , D(03), M(1)
[ 180.044726] pin0c, enabled , edge , high, V(3C), IRR(0), S(0), logical , D(03), M(1)
[ 180.058970] pin0d, enabled , edge , high, V(3D), IRR(0), S(0), logical , D(03), M(1)
[ 180.060198] pin0e, enabled , edge , high, V(3E), IRR(0), S(0), logical , D(03), M(1)
[ 180.061333] pin0f, enabled , edge , high, V(3F), IRR(0), S(0), logical , D(03), M(1)
[ 180.062477] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.063610] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.064742] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.065874] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.067035] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.068186] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.069358] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.070571] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0)
[ 180.071753] IRQ to pin mappings:
[ 180.085523] IRQ0 -> 0:2
[ 180.085955] IRQ1 -> 0:1
[ 180.086376] IRQ3 -> 0:3
[ 180.086812] IRQ4 -> 0:4
[ 180.087238] IRQ5 -> 0:5
[ 180.087631] IRQ6 -> 0:6
[ 180.088029] IRQ7 -> 0:7
[ 180.088422] IRQ8 -> 0:8
[ 180.088818] IRQ9 -> 0:9
[ 180.089218] IRQ10 -> 0:10
[ 180.089634] IRQ11 -> 0:11
[ 180.090057] IRQ12 -> 0:12
[ 180.090476] IRQ13 -> 0:13
[ 180.090892] IRQ14 -> 0:14
[ 180.091319] IRQ15 -> 0:15
[ 180.091751] .................................... done.
[ 180.092501] Using IPI Shortcut mode
[ 180.093111] sched_clock: Marking stable (180086795799, 0)->(182833820934, -2747025135)
[ 180.095580] page_owner is disabled
[ 180.174990] Key type big_key registered
[ 180.176740] Key type trusted registered
[ 180.177960] Key type encrypted registered
[ 180.184491] OF: Duplicate name in testcase-data, renamed to "duplicate-name#1"
[ 180.212989] ### dt-test ### start of unittest - you will see error messages
[ 180.241091] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1
[ 180.242967] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1
[ 180.244822] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle
[ 180.245949] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle
[ 180.247147] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property
[ 180.266573] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property
[ 180.326584] OF: overlay: overlay_is_topmost: #5 clashes #6 @/testcase-data/overlay-node/test-bus/test-unittest8
[ 180.328173] OF: overlay: overlay #5 is not topmost
[ 180.371282] i2c i2c-0: Added multiplexed i2c bus 1
[ 180.380712] i2c i2c-0: Added multiplexed i2c bus 2
[ 180.407617] ### dt-test ### FAIL of_unittest_overlay_high_level():2201 overlay_base_root not initialized
[ 180.409091] ### dt-test ### end of unittest - 188 passed, 1 failed
[ 180.451958] Freeing unused kernel memory: 916K
[ 180.515111] Write protecting the kernel text: 10848k
[ 180.546355] Write protecting the kernel read-only data: 5548k
[ 181.526091] init: Failed to create pty - disabling logging for job
[ 181.527300] init: Temporary process spawn error: No such file or directory
[ 181.710516] init: Failed to create pty - disabling logging for job
[ 181.711738] init: Temporary process spawn error: No such file or directory
[ 182.029617] init: Failed to create pty - disabling logging for job
[ 182.030848] init: Temporary process spawn error: No such file or directory
[ 182.035952] init: Failed to create pty - disabling logging for job
[ 182.037281] init: Temporary process spawn error: No such file or directory
[ 182.526324] init: Failed to create pty - disabling logging for job
[ 182.527483] init: Temporary process spawn error: No such file or directory
[ 182.550539] init: Failed to create pty - disabling logging for job
[ 182.551699] init: Temporary process spawn error: No such file or directory
[ 182.616316] init: Failed to create pty - disabling logging for job
[ 182.617543] init: Temporary process spawn error: No such file or directory
[ 182.641534] init: Failed to create pty - disabling logging for job
[ 182.643929] init: Temporary process spawn error: No such file or directory
[ 182.663095] init: Failed to create pty - disabling logging for job
[ 182.664261] init: Temporary process spawn error: No such file or directory
[ 182.705015] init: plymouth-log main process (215) terminated with status 1
[ 182.708633] udevd[217]: starting version 175
[ 182.726986] init: Failed to create pty - disabling logging for job
[ 182.728132] init: Temporary process spawn error: No such file or directory
[ 182.780630] init: Failed to create pty - disabling logging for job
[ 182.781806] init: Temporary process spawn error: No such file or directory
[ 182.814577] init: Failed to create pty - disabling logging for job
[ 182.815741] init: Temporary process spawn error: No such file or directory
udevd[226]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:LNXSYSTM:': No such file or directory
udevd[232]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:LNXSYBUS:': No such file or directory
udevd[235]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d00001237sv00001AF4sd00001100bc06sc00i00': No such file or directory
udevd[242]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv fmc': No such file or directory
udevd[243]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:LNXSYBUS:': No such file or directory
udevd[241]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d00007010sv00001AF4sd00001100bc01sc01i80': No such file or directory
udevd[249]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d0000100Esv00001AF4sd00001100bc02sc00i00': No such file or directory
udevd[245]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[246]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[248]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[252]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0A03:': No such file or directory
udevd[258]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0103:': No such file or directory
udevd[261]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d00007000sv00001AF4sd00001100bc06sc01i00': No such file or directory
udevd[257]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0C0F:': No such file or directory
udevd[260]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0C0F:': No such file or directory
udevd[262]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0C0F:': No such file or directory
udevd[251]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:ACPI0010:PNP0A05:': No such file or directory
udevd[250]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001234d00001111sv00001AF4sd00001100bc03sc00i00': No such file or directory
udevd[244]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d00007113sv00001AF4sd00001100bc06sc80i00': No such file or directory
udevd[269]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0A06:': No such file or directory
udevd[265]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0A06:': No such file or directory
udevd[266]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[270]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[276]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:QEMU0002:': No such file or directory
udevd[259]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv input:b0019v0000p0001e0000-e0,1,k74,ramlsfw': No such file or directory
udevd[268]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0C0F:': No such file or directory
udevd[281]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0A06:': No such file or directory
udevd[271]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[267]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0C0F:': No such file or directory
udevd[308]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0501:': No such file or directory
udevd[304]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00001AF4d00001001sv00001AF4sd00000002bc01sc00i00': No such file or directory
udevd[309]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:LNXCPU:': No such file or directory
udevd[310]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0303:': No such file or directory
udevd[314]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:LNXCPU:': No such file or directory
udevd[319]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv of:Ntestcase-device2T<NULL>Ctestcase-device': No such file or directory
udevd[320]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv platform:vpd': No such file or directory
udevd[315]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0103:': No such file or directory
udevd[307]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0501:': No such file or directory
udevd[311]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0400:': No such file or directory
udevd[306]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0700:': No such file or directory
udevd[305]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0B00:': No such file or directory
udevd[318]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv platform:dell_rbu': No such file or directory
udevd[316]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv platform:platform-framebuffer': No such file or directory
udevd[312]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv pci:v00008086d000025ABsv00001AF4sd00001100bc08sc80i00': No such file or directory
udevd[317]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:QEMU0002:': No such file or directory
udevd[322]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv of:Ni2c-test-busT<NULL>Cunittest-i2c-bus': No such file or directory
udevd[321]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv of:Ntestcase-device1T<NULL>Ctestcase-device': No such file or directory
udevd[313]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv acpi:PNP0F13:': No such file or directory
udevd[323]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv platform:memconsole': No such file or directory
udevd[324]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv input:b0011v0001p0001eAB41-e0,1,4,11,14,k71,72,73,74,75,76,77,79,7A,7B,7C,7D,7E,7F,80,8C,8E,8F,9B,9C,9D,9E,9F,A3,A4,A5,A6,AC,AD,B7,B8,B9,D9,E2,ram4,l0,1,2,sfw': No such file or directory
udevd[325]: failed to execute '/sbin/modprobe' '/sbin/modprobe -bv serio:ty01pr00id00ex00': No such file or directory
[ 184.649665] init: Failed to create pty - disabling logging for job
[ 184.650814] init: Temporary process spawn error: No such file or directory
[ 184.763086] init: Failed to create pty - disabling logging for job
[ 184.764240] init: Temporary process spawn error: No such file or directory
[ 184.845260] init: Failed to create pty - disabling logging for job
[ 184.869159] init: Temporary process spawn error: No such file or directory
[ 184.899790] init: Failed to create pty - disabling logging for job
[ 184.901144] init: Temporary process spawn error: No such file or directory
[ 185.453651] init: failsafe main process (332) killed by TERM signal
[ 186.123517] init: Failed to create pty - disabling logging for job
[ 186.124653] init: Temporary process spawn error: No such file or directory
[ 186.151715] init: Failed to create pty - disabling logging for job
[ 186.152858] init: Temporary process spawn error: No such file or directory
[ 186.231842] init: Failed to create pty - disabling logging for job
[ 186.233003] init: Temporary process spawn error: No such file or directory
[ 186.242013] init: Failed to create pty - disabling logging for job
[ 186.285872] init: Temporary process spawn error: No such file or directory
[ 186.292344] init: Failed to create pty - disabling logging for job
[ 186.293681] init: Temporary process spawn error: No such file or directory
Kernel tests: Boot OK!
Trinity v1.4pre Dave Jones <davej@xxxxxxxxxx>
[init] Marking syscall get_robust_list (312) as to be disabled.
Done parsing arguments.
Marking all syscalls as enabled.
[init] Disabling syscalls marked as disabled by command line options
[init] Marked syscall get_robust_list (312) as deactivated.
[init] Enabled 350 syscalls. Disabled 1 syscalls.
DANGER: RUNNING AS ROOT.
Unless you are running in a virtual machine, this could cause serious problems such as overwriting CMOS
or similar which could potentially make this machine unbootable without a firmware reset.

ctrl-c now unless you really know what you are doing.
[ 187.661124] init: Temporary process spawn error: No such file or directory
[ 187.710721] init: Failed to create pty - disabling logging for job
[ 187.711949] init: Temporary process spawn error: No such file or directory
[ 187.755448] init: udev-fallback-graphics main process (412) terminated with status 127
[ 187.761885] init: Failed to create pty - disabling logging for job
[ 187.779467] init: Temporary process spawn error: No such file or directory
[ 187.803947] init: Failed to create pty - disabling logging for job
[ 187.805816] init: Temporary process spawn error: No such file or directory
[ 187.855027] init: plymouth-splash main process (418) terminated with status 1
[ 187.953296] init: networking main process (419) terminated with status 1
[ 191.697721] ------------[ cut here ]------------
[ 191.699318] WARNING: CPU: 0 PID: 424 at kernel/locking/lockdep.c:3928 check_flags+0x119/0x1b0
[ 191.700967] CPU: 0 PID: 424 Comm: trinity-main Not tainted 4.14.0-rc3-00002-gc394639 #1
[ 191.702200] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 191.703476] task: c82fec80 task.stack: c8bbe000
[ 191.704194] EIP: check_flags+0x119/0x1b0
[ 191.704809] EFLAGS: 00010086 CPU: 0
[ 191.705380] EAX: 0000002e EBX: c82fec80 ECX: 00000107 EDX: b8afe274
[ 191.716483] ESI: c8003400 EDI: 00000000 EBP: c6de5c5c ESP: c6de5c54
[ 191.717457] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 191.718350] CR0: 80050033 CR2: 0858f014 CR3: 18035000 CR4: 00000690
[ 191.719405] Call Trace:
[ 191.719823] <SOFTIRQ>
[ 191.720241] lock_acquire+0x3d/0x230
[ 191.720819] ? perf_event_output_forward+0x14/0x180
[ 191.721601] ? __rcu_read_lock+0x3/0x20
[ 191.722218] perf_event_output_forward+0x41/0x180
[ 191.722958] ? perf_prepare_sample+0x830/0x830
[ 191.723657] ? __perf_event_account_interrupt+0x215/0x240
[ 191.724508] ? perf_prepare_sample+0x830/0x830
[ 191.725213] __perf_event_overflow+0x98/0x150
[ 191.725898] perf_swevent_overflow+0x9e/0xe0
[ 191.736679] perf_swevent_event+0x153/0x1a0
[ 191.737345] perf_tp_event+0x110/0x440
[ 191.737943] ? check_preemption_disabled+0x3d/0x1a0
[ 191.738759] ? check_preemption_disabled+0x3d/0x1a0
[ 191.739568] ? debug_smp_processor_id+0x12/0x20
[ 191.740332] ? perf_trace_buf_alloc+0xf9/0x1c0
[ 191.741107] perf_ftrace_function_call+0xe0/0xf0
[ 191.741866] ? __local_bh_enable+0x99/0xa0
[ 191.742586] ? ftrace_ops_no_ops+0x334/0x380
[ 191.743263] ftrace_ops_no_ops+0x334/0x380
[ 191.743924] ? check_preemption_disabled+0x3d/0x1a0
[ 191.744695] ? __local_bh_enable+0x99/0xa0
[ 191.745350] ? preempt_count_sub+0x8/0x2e0
[ 191.746000] ftrace_stub+0x14/0x1c
[ 191.756703] ? preempt_count_sub+0xd/0x2e0
[ 191.757404] ? trace_softirqs_on+0xf2/0x150
[ 191.758079] __local_bh_enable+0x99/0xa0
[ 191.758786] __do_softirq+0x6a5/0x9c0
[ 191.759440] ? __irqentry_text_end+0x6/0x6
[ 191.760096] do_softirq_own_stack+0x30/0x40
[ 191.760788] </SOFTIRQ>
[ 191.761230] irq_exit+0x56/0xd0
[ 191.761796] smp_apic_timer_interrupt+0x48d/0x6f0
[ 191.762571] apic_timer_interrupt+0x3a/0x40
[ 191.763298] EIP: lock_acquire+0x1d6/0x230
[ 191.763933] EFLAGS: 00000246 CPU: 0
[ 191.764548] EAX: 00000246 EBX: c82fec80 ECX: 6b96419b EDX: 00000000
[ 191.765567] ESI: 00000246 EDI: 00000000 EBP: c8bbfe64 ESP: c8bbfe30
[ 191.776469] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 191.777395] ? cgroup1_procs_write+0xb/0x20
[ 191.778068] ? handle_pte_fault+0x55f/0x1cc0
[ 191.778837] _raw_spin_lock+0x42/0x50
[ 191.779447] ? handle_pte_fault+0x55f/0x1cc0
[ 191.780119] handle_pte_fault+0x55f/0x1cc0
[ 191.780849] handle_mm_fault+0x531/0x700
[ 191.781504] ? handle_mm_fault+0x72/0x700
[ 191.782194] __do_page_fault+0xa8a/0xbd0
[ 191.782855] do_page_fault+0x2cc/0x422
[ 191.783471] ? kvm_read_and_reset_pf_reason+0x70/0x70
[ 191.784293] do_async_page_fault+0x26/0x60
[ 191.796340] common_exception+0x3d/0x42
[ 191.796973] EIP: 0xa7de393e
[ 191.797401] EFLAGS: 00010206 CPU: 0
[ 191.797924] EAX: 00000000 EBX: a7f0eff4 ECX: 00001ff1 EDX: 0858f010
[ 191.798902] ESI: 0858d008 EDI: 00002009 EBP: 00000004 ESP: afe7c120
[ 191.799828] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 191.800679] ? kvm_read_and_reset_pf_reason+0x70/0x70
[ 191.801453] Code: 00 85 c0 74 75 e8 88 8d 2f 00 85 c0 74 6c 83 3d cc c1 57 ba 00 75 63 c7 44 24 04 34 da 92 b9 c7 04 24 0a 93 91 b9 e8 ec 3b 01 00 <0f> ff eb 4b 8d 76 00 8b 0d 88 2a 54 ba 85 c9 75 3e 64 a1 4c 68
[ 191.804438] ---[ end trace 70000c51373576aa ]---
[ 191.805188] irq event stamp: 362178
[ 191.805708] hardirqs last enabled at (362176): [<b9490faa>] restore_all+0xf/0x25
[ 191.816989] hardirqs last disabled at (362177): [<b9496420>] __do_softirq+0xf0/0x9c0
[ 191.818122] softirqs last enabled at (362178): [<b94969d5>] __do_softirq+0x6a5/0x9c0
[ 191.819324] softirqs last disabled at (362171): [<b8a10ce0>] do_softirq_own_stack+0x30/0x40
[ 196.174500] init: tty4 main process ended, respawning
[ 196.249472] init: tty5 main process (375) terminated with status 1
[ 196.251170] init: tty5 main process ended, respawning
[ 196.270393] init: tty2 main process (377) terminated with status 1
[ 196.272059] init: tty2 main process ended, respawning
[ 196.428413] init: tty3 main process ended, respawning
[ 196.430660] init: tty6 main process (379) terminated with status 1
[ 196.437890] init: tty6 main process ended, respawning
[init] Using pid_max = 32768
[init] Kernel was tainted on startup. Will ignore flags that are already set.
[init] Started watchdog process, PID is 430
[main] Main thread is alive.
[main] Setsockopt(1 a 80d3000 7e) on fd 8 [1:1:1]
[main] Setsockopt(1 a 80d3000 13) on fd 11 [1:5:1]
[main] Setsockopt(1 9 80d3000 4) on fd 12 [1:1:1]
[main] Setsockopt(10e 3 80d3000 ce) on fd 13 [16:2:2]
[main] Setsockopt(1 2c 80d3000 4) on fd 15 [16:3:16]
[main] Setsockopt(1 2d 80d3000 4) on fd 18 [1:1:1]
[main] Setsockopt(1 2e 80d3000 4) on fd 22 [1:5:1]
[main] Setsockopt(1 1d 80d3000 9b) on fd 23 [1:2:1]
[main] Setsockopt(1 8 80d3000 4) on fd 24 [1:2:1]
[main] Setsockopt(1 5 80d3000 4) on fd 26 [1:1:1]
[main] Setsockopt(1 5 80d3000 17) on fd 27 [1:1:1]
[main] Setsockopt(1 6 80d3000 4) on fd 28 [1:2:1]
[main] Setsockopt(1 2d 80d3000 bc) on fd 29 [1:2:1]
[main] Setsockopt(10e 4 80d3000 5d) on fd 30 [16:3:0]
[main] Setsockopt(1 8 80d3000 4) on fd 31 [1:1:1]
[main] Setsockopt(10e 2 80d3000 24) on fd 32 [16:3:15]
[main] Setsockopt(1 c 80d3000 4) on fd 33 [1:5:1]
[main] Setsockopt(1 12 80d3000 4) on fd 34 [1:5:1]
[main] Setsockopt(1 e 80d3000 4) on fd 35 [16:2:4]
[main] Setsockopt(1 f 80d3000 4) on fd 36 [1:2:1]
[main] Setsockopt(1 2b 80d3000 4) on fd 37 [1:2:1]
[main] Setsockopt(1 c 80d3000 4) on fd 38 [1:1:1]
[main] Setsockopt(1 2d 80d3000 4) on fd 39 [16:2:15]
[main] Setsockopt(1 2d 80d3000 e2) on fd 40 [1:2:1]
[main] Setsockopt(1 20 80d3000 ae) on fd 41 [1:2:1]
[main] Setsockopt(1 1 80d3000 4) on fd 43 [1:2:1]
[main] Setsockopt(1 9 80d3000 34) on fd 44 [1:2:1]
[main] Setsockopt(10e 3 80d3000 4) on fd 46 [16:2:15]
[main] Setsockopt(10e 4 80d3000 24) on fd 49 [16:3:0]
[main] Setsockopt(1 2c 80d3000 4) on fd 52 [1:5:1]
[main] Setsockopt(1 5 80d3000 3e) on fd 54 [1:5:1]
[main] Setsockopt(1 2f 80d3000 ba) on fd 55 [1:5:1]
[main] Setsockopt(1 10 80d3000 4) on fd 57 [1:2:1]
[main] Setsockopt(1 28 80d3000 4) on fd 59 [1:1:1]
[main] Setsockopt(1 1d 80d3000 4) on fd 60 [1:2:1]
[main] Setsockopt(1 2d 80d3000 de) on fd 61 [1:1:1]
[main] Setsockopt(1 10 80d3000 4) on fd 62 [1:1:1]
[main] Setsockopt(1 23 80d3000 b3) on fd 63 [16:3:4]
[main] Setsockopt(1 24 80d3000 52) on fd 64 [1:1:1]
[main] Setsockopt(10e 2 80d3000 a1) on fd 65 [16:2:16]
[main] Setsockopt(1 2e 80d3000 4) on fd 66 [1:5:1]
[main] Setsockopt(1 9 80d3000 4) on fd 67 [1:5:1]
[main] Setsockopt(1 b 80d3000 4) on fd 73 [1:2:1]
[main] Setsockopt(1 2 80d3000 4) on fd 75 [1:1:1]
[main] Setsockopt(1 e 80d3000 ab) on fd 77 [1:2:1]
[main] Setsockopt(1 21 80d3000 4) on fd 79 [1:1:1]
[main] Setsockopt(1 29 80d3000 3b) on fd 80 [16:3:0]
[main] Setsockopt(1 f 80d3000 4) on fd 81 [1:1:1]
[main] Setsockopt(1 12 80d3000 8b) on fd 82 [1:2:1]
[main] Setsockopt(1 1d 80d3000 4) on fd 83 [1:5:1]
[main] Setsockopt(1 2c 80d3000 b5) on fd 84 [1:5:1]
[main] Setsockopt(1 a 80d3000 4) on fd 86 [1:2:1]
[main] Setsockopt(1 5 80d3000 5a) on fd 87 [1:2:1]
[main] Setsockopt(1 2d 80d3000 7e) on fd 88 [1:5:1]
[main] Setsockopt(1 20 80d3000 4) on fd 90 [16:3:16]
[main] Setsockopt(1 b 80d3000 9b) on fd 92 [1:5:1]
[main] Setsockopt(1 c 80d3000 56) on fd 93 [1:1:1]
[main] Setsockopt(1 7 80d3000 4) on fd 95 [1:2:1]
[main] Setsockopt(1 21 80d3000 7) on fd 96 [1:5:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 97 [16:2:15]
[main] Setsockopt(1 29 80d3000 4) on fd 98 [1:1:1]
[main] Setsockopt(1 21 80d3000 a9) on fd 100 [1:2:1]
[main] Setsockopt(1 2c 80d3000 4) on fd 101 [1:5:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 102 [16:3:0]
[main] Setsockopt(10e 2 80d3000 a8) on fd 104 [16:3:16]
[main] Setsockopt(1 20 80d3000 b8) on fd 107 [1:1:1]
[main] Setsockopt(1 29 80d3000 25) on fd 109 [1:2:1]
[main] Setsockopt(1 b 80d3000 4) on fd 112 [1:5:1]
[main] Setsockopt(1 a 80d3000 4) on fd 113 [1:1:1]
[main] Setsockopt(1 21 80d3000 7) on fd 114 [1:5:1]
[main] Setsockopt(1 6 80d3000 4) on fd 116 [1:1:1]
[main] Setsockopt(1 12 80d3000 d8) on fd 117 [1:2:1]
[main] Setsockopt(1 15 80d3000 8) on fd 119 [1:5:1]
[main] Setsockopt(1 2f 80d3000 94) on fd 121 [16:3:16]
[main] Setsockopt(1 2d 80d3000 4) on fd 123 [1:2:1]
[main] Setsockopt(1 2c 80d3000 4) on fd 124 [16:2:4]
[main] Setsockopt(1 2d 80d3000 4) on fd 125 [1:1:1]
[main] Setsockopt(10e 3 80d3000 bf) on fd 126 [16:2:16]
[main] Setsockopt(1 8 80d3000 4) on fd 127 [1:5:1]
[main] Setsockopt(1 c 80d3000 86) on fd 128 [1:5:1]
[main] Setsockopt(1 21 80d3000 4) on fd 129 [1:2:1]
[main] Setsockopt(1 15 80d3000 8) on fd 136 [1:1:1]
[main] Setsockopt(10e 1 80d3000 4) on fd 137 [16:3:0]
[main] Setsockopt(1 22 80d3000 90) on fd 139 [1:1:1]
[main] Setsockopt(1 c 80d3000 4) on fd 143 [1:1:1]
[main] Setsockopt(1 23 80d3000 10) on fd 144 [1:5:1]
[main] Setsockopt(1 12 80d3000 4) on fd 147 [1:1:1]
[main] Setsockopt(1 25 80d3000 4) on fd 148 [16:2:15]
[main] Setsockopt(1 d 80d3000 8) on fd 149 [1:1:1]
[main] Setsockopt(1 2f 80d3000 4) on fd 150 [1:1:1]
[main] Setsockopt(1 e 80d3000 4) on fd 151 [1:2:1]
[main] Setsockopt(1 23 80d3000 4) on fd 152 [1:2:1]
[main] Setsockopt(1 29 80d3000 48) on fd 154 [1:5:1]
[main] Setsockopt(1 5 80d3000 4) on fd 155 [1:1:1]
[main] Setsockopt(10e 3 80d3000 4) on fd 156 [16:2:2]
[main] Setsockopt(1 1d 80d3000 6b) on fd 161 [1:1:1]
[main] Setsockopt(1 c 80d3000 4) on fd 162 [1:2:1]
[main] Setsockopt(1 2c 80d3000 28) on fd 163 [16:2:15]
[main] Setsockopt(1 24 80d3000 4) on fd 165 [16:3:15]
[main] Setsockopt(10e 5 80d3000 4) on fd 169 [16:2:4]
[main] Setsockopt(1 20 80d3000 4) on fd 171 [1:1:1]
[main] Setsockopt(1 9 80d3000 4) on fd 173 [1:1:1]
[main] Setsockopt(1 9 80d3000 58) on fd 175 [1:5:1]
[main] Setsockopt(1 8 80d3000 ac) on fd 177 [1:5:1]
[main] Setsockopt(1 8 80d3000 4) on fd 178 [1:1:1]
[main] Setsockopt(1 23 80d3000 3f) on fd 180 [1:2:1]
[main] Setsockopt(1 2c 80d3000 b2) on fd 181 [1:1:1]
[main] Setsockopt(1 b 80d3000 4) on fd 183 [1:5:1]
[main] Setsockopt(1 5 80d3000 d5) on fd 184 [1:2:1]
[main] Setsockopt(10e 4 80d3000 98) on fd 188 [16:3:16]
[main] Setsockopt(1 9 80d3000 8e) on fd 189 [1:2:1]
[main] Setsockopt(1 f 80d3000 4) on fd 191 [1:2:1]
[main] Setsockopt(1 f 80d3000 4) on fd 192 [1:1:1]
[main] Setsockopt(1 2c 80d3000 4) on fd 193 [1:5:1]
[main] Setsockopt(1 1d 80d3000 4) on fd 195 [1:1:1]
[main] Setsockopt(1 10 80d3000 79) on fd 196 [1:5:1]
[main] Setsockopt(1 1d 80d3000 3c) on fd 197 [16:3:4]
[main] Setsockopt(1 c 80d3000 4) on fd 199 [1:1:1]
[main] Setsockopt(10e 4 80d3000 8d) on fd 200 [16:3:15]
[main] Setsockopt(1 b 80d3000 4) on fd 203 [1:1:1]
[main] Setsockopt(1 2 80d3000 4) on fd 205 [1:1:1]
[main] Setsockopt(1 8 80d3000 4) on fd 206 [16:3:4]
[main] Setsockopt(1 b 80d3000 cb) on fd 208 [1:2:1]
[main] Setsockopt(1 2 80d3000 4) on fd 211 [1:5:1]
[main] Setsockopt(1 8 80d3000 4) on fd 213 [1:1:1]
[main] Setsockopt(1 2b 80d3000 40) on fd 215 [16:3:16]
[main] Setsockopt(1 23 80d3000 4) on fd 217 [1:2:1]
[main] Setsockopt(1 9 80d3000 4) on fd 219 [1:1:1]
[main] Setsockopt(10e 4 80d3000 3d) on fd 221 [16:3:4]
[main] Setsockopt(1 20 80d3000 e2) on fd 223 [1:2:1]
[main] Setsockopt(1 9 80d3000 4) on fd 224 [1:1:1]
[main] Setsockopt(1 e 80d3000 f8) on fd 225 [1:2:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 226 [16:2:4]
[main] Setsockopt(1 d 80d3000 8) on fd 227 [1:5:1]
[main] Setsockopt(1 5 80d3000 4) on fd 228 [1:1:1]
[main] Setsockopt(1 10 80d3000 4) on fd 229 [1:2:1]
[main] Setsockopt(1 12 80d3000 4) on fd 230 [16:2:16]
[main] Setsockopt(1 2 80d3000 4) on fd 231 [1:1:1]
[main] Setsockopt(10e 3 80d3000 4) on fd 232 [16:2:0]
[main] Setsockopt(1 25 80d3000 8a) on fd 233 [1:2:1]
[main] Setsockopt(1 2e 80d3000 e) on fd 234 [1:2:1]
[main] Setsockopt(1 1d 80d3000 4) on fd 236 [1:2:1]
[main] Setsockopt(1 2f 80d3000 4) on fd 237 [16:3:4]
[main] Setsockopt(1 8 80d3000 f5) on fd 238 [1:5:1]
[main] Setsockopt(1 2b 80d3000 4) on fd 239 [1:2:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 242 [16:2:2]
[main] Setsockopt(1 29 80d3000 94) on fd 243 [1:1:1]
[main] Setsockopt(1 12 80d3000 4) on fd 244 [1:5:1]
[main] Setsockopt(1 b 80d3000 45) on fd 246 [1:1:1]
[main] Setsockopt(1 8 80d3000 5) on fd 247 [1:2:1]
[main] Setsockopt(1 6 80d3000 4) on fd 252 [1:5:1]
[main] Setsockopt(1 9 80d3000 4) on fd 253 [16:2:0]
[main] Setsockopt(1 e 80d3000 3b) on fd 254 [1:5:1]
[main] Setsockopt(1 23 80d3000 94) on fd 256 [16:2:0]
[main] Setsockopt(1 7 80d3000 4) on fd 257 [1:1:1]
[main] Setsockopt(1 25 80d3000 2a) on fd 258 [1:2:1]
[main] Setsockopt(10e 4 80d3000 4) on fd 259 [16:2:16]
[main] Setsockopt(10e 3 80d3000 4) on fd 262 [16:3:2]
[main] Setsockopt(1 a 80d3000 4) on fd 263 [1:2:1]
[main] Setsockopt(1 2f 80d3000 b2) on fd 265 [1:1:1]
[main] Setsockopt(1 6 80d3000 4) on fd 267 [1:5:1]
[main] Setsockopt(1 9 80d3000 4) on fd 268 [1:1:1]
[main] Setsockopt(1 a 80d3000 13) on fd 270 [1:2:1]
[main] Setsockopt(1 a 80d3000 4) on fd 271 [1:2:1]
[main] Setsockopt(1 23 80d3000 4) on fd 272 [1:2:1]
[main] Setsockopt(1 23 80d3000 fd) on fd 273 [1:1:1]
[main] Setsockopt(10e 3 80d3000 67) on fd 275 [16:3:0]
[main] Setsockopt(1 2b 80d3000 4) on fd 277 [16:2:4]
[main] Setsockopt(1 23 80d3000 f2) on fd 278 [1:1:1]
[main] Setsockopt(1 2c 80d3000 4) on fd 280 [1:1:1]
[main] Setsockopt(1 c 80d3000 4) on fd 281 [1:1:1]
[main] Setsockopt(1 5 80d3000 4) on fd 282 [1:5:1]
[main] Setsockopt(1 2b 80d3000 48) on fd 283 [1:1:1]
[main] Setsockopt(1 9 80d3000 4) on fd 285 [1:2:1]
[main] Setsockopt(1 12 80d3000 16) on fd 287 [16:2:0]
[main] Setsockopt(10e 3 80d3000 4) on fd 290 [16:3:4]
[main] Setsockopt(1 2c 80d3000 4) on fd 291 [1:5:1]
[main] Setsockopt(1 23 80d3000 69) on fd 292 [16:3:4]
[main] Setsockopt(1 24 80d3000 10) on fd 293 [1:5:1]
[main] Setsockopt(10e 3 80d3000 4) on fd 294 [16:2:2]
[main] Setsockopt(1 2e 80d3000 71) on fd 295 [1:5:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 297 [16:3:2]
[main] Setsockopt(1 7 80d3000 5) on fd 298 [1:5:1]
[main] Setsockopt(1 2c 80d3000 82) on fd 299 [1:2:1]
[main] Setsockopt(1 8 80d3000 a0) on fd 300 [1:5:1]
[main] Setsockopt(1 b 80d3000 4) on fd 302 [1:5:1]
[main] Setsockopt(1 f 80d3000 4) on fd 305 [1:5:1]
[main] Setsockopt(1 23 80d3000 4) on fd 306 [1:1:1]
[main] Setsockopt(10e 5 80d3000 4) on fd 307 [16:3:2]
[main] Setsockopt(1 2e 80d3000 85) on fd 308 [1:2:1]
[main] Setsockopt(1 2f 80d3000 4) on fd 315 [1:2:1]
[main] Setsockopt(1 e 80d3000 b2) on fd 318 [1:1:1]
[main] Setsockopt(1 f 80d3000 ee) on fd 319 [1:2:1]
[main] Setsockopt(10e 5 80d3000 27) on fd 327 [16:3:0]
[main] Setsockopt(1 a 80d3000 4) on fd 329 [1:1:1]
[main] Setsockopt(1 9 80d3000 4) on fd 330 [1:2:1]
[main] Setsockopt(1 6 80d3000 4) on fd 332 [1:1:1]
[main] Setsockopt(1 25 80d3000 4) on fd 334 [16:2:0]
[main] Setsockopt(1 2f 80d3000 4) on fd 335 [1:2:1]
[main] Setsockopt(1 24 80d3000 a4) on fd 339 [1:2:1]
[main] Setsockopt(1 29 80d3000 4) on fd 341 [1:1:1]
[main] Setsockopt(1 7 80d3000 74) on fd 342 [1:5:1]
[main] Setsockopt(1 25 80d3000 4) on fd 344 [1:2:1]
[main] Setsockopt(1 2d 80d3000 9e) on fd 346 [1:5:1]
[main] Setsockopt(1 2a 80d3000 81) on fd 348 [1:2:1]
[main] Setsockopt(1 2d 80d3000 4) on fd 350 [1:2:1]
[main] Setsockopt(1 b 80d3000 4) on fd 351 [1:2:1]
[main] Setsockopt(1 8 80d3000 4) on fd 352 [1:1:1]
[main] Setsockopt(1 28 80d3000 73) on fd 353 [16:2:0]
[main] Setsockopt(1 b 80d3000 78) on fd 356 [1:1:1]
[main] Setsockopt(1 2b 80d3000 5) on fd 358 [16:2:16]
[main] Setsockopt(1 2c 80d3000 4) on fd 359 [1:1:1]
[main] Setsockopt(1 7 80d3000 2e) on fd 360 [1:2:1]
[main] Setsockopt(1 21 80d3000 f7) on fd 363 [1:2:1]
[main] Setsockopt(1 e 80d3000 4) on fd 364 [1:1:1]
[main] Setsockopt(1 21 80d3000 2b) on fd 365 [1:2:1]
[main] Setsockopt(1 23 80d3000 23) on fd 368 [1:2:1]
[main] Setsockopt(1 29 80d3000 4) on fd 369 [1:2:1]
[main] Setsockopt(1 23 80d3000 4) on fd 371 [1:2:1]
[main] Setsockopt(1 f 80d3000 4) on fd 373 [1:1:1]
[main] Setsockopt(1 6 80d3000 e3) on fd 375 [1:1:1]
[main] Setsockopt(1 23 80d3000 4) on fd 376 [16:3:16]
[main] Setsockopt(1 d 80d3000 8) on fd 379 [1:1:1]
[main] 375 sockets created based on info from socket cachefile.
[main] Generating file descriptors
[main] Added 297 filenames from /dev
[main] Added 7683 filenames from /proc
[main] Added 16137 filenames from /sys
[child0:432] setuid16 (23) returned ENOSYS, marking as inactive.
[child0:432] kexec_load (283) returned ENOSYS, marking as inactive.
[child0:432] set_mempolicy (276) returned ENOSYS, marking as inactive.
[child0:432] mq_timedreceive (280) returned ENOSYS, marking as inactive.
[child0:432] getresuid16 (165) returned ENOSYS, marking as inactive.
[child0:432] getuid16 (24) returned ENOSYS, marking as inactive.
[child0:432] mq_timedsend (279) returned ENOSYS, marking as inactive.
[child0:432] ioprio_set (289) returned ENOSYS, marking as inactive.
[child0:432] setgroups16 (81) returned ENOSYS, marking as inactive.
[child0:432] uid changed! Was: 0, now 2147483129
[watchdog] [430] Watchdog exiting
[child1:433] child exiting.
Bailing main loop. Exit reason: UID changed.
[init]
Ran 64 syscalls. Successes: 18 Failures: 45
[ 206.249191] init: tty4 main process (425) terminated with status 1
[ 206.250342] init: tty4 main process ended, respawning
[ 206.369538] init: tty5 main process (426) terminated with status 1
[ 206.370845] init: tty5 main process ended, respawning
[ 206.448921] init: tty2 main process (427) terminated with status 1
[ 206.463355] init: tty2 main process ended, respawning
[ 206.479870] init: tty3 main process (428) terminated with status 1
[ 206.481178] init: tty3 main process ended, respawning
[ 206.503949] init: tty6 main process (429) terminated with status 1
[ 206.505164] init: tty6 main process ended, respawning
[ 211.929517] Writes: Total: 4 Max/Min: 0/0 Fail: 0
[ 216.293653] init: tty4 main process (434) terminated with status 1
[ 216.294561] init: tty4 main process ended, respawning
[ 216.402146] init: tty5 main process (435) terminated with status 1
[ 216.403053] init: tty5 main process ended, respawning
[ 216.512841] init: tty2 main process (436) terminated with status 1
[ 216.513766] init: tty2 main process ended, respawning
[ 216.541597] init: tty3 main process (437) terminated with status 1
[ 216.542503] init: tty3 main process ended, respawning
[ 216.554569] init: tty6 main process (438) terminated with status 1
[ 216.555492] init: tty6 main process ended, respawning
[ 226.314452] init: tty4 main process (441) terminated with status 1
[ 226.315720] init: tty4 main process ended, respawning
[ 226.424440] init: tty5 main process (442) terminated with status 1
[ 226.425825] init: tty5 main process ended, respawning
[ 226.545567] init: tty2 main process (443) terminated with status 1
[ 226.546773] init: tty2 main process ended, respawning
[ 226.556096] init: tty3 main process (444) terminated with status 1
[ 226.557337] init: tty3 main process ended, respawning
[ 226.586220] init: tty6 main process (445) terminated with status 1
[ 226.587215] init: tty6 main process ended, respawning
[ 236.325061] init: tty4 main process (446) terminated with status 1
[ 236.325734] init: tty4 main process ended, respawning
[ 236.435326] init: tty5 main process (447) terminated with status 1
[ 236.437069] init: tty5 main process ended, respawning
[ 236.564516] init: tty2 main process (448) terminated with status 1
[ 236.565213] init: tty2 main process ended, respawning
[ 236.575253] init: tty3 main process (449) terminated with status 1
[ 236.575958] init: tty3 main process ended, respawning
[ 236.607209] init: tty6 main process (450) terminated with status 1
[ 236.607951] init: tty6 main process ended, respawning
error: 'rc.local' exited outside the expected code flow.
[ 240.877210] init: Failed to create pty - disabling logging for job
[ 240.877968] init: Temporary process spawn error: No such file or directory
[ 240.898302] init: rc main process (373) killed by TERM signal
[ 240.904572] init: tty4 main process (451) killed by TERM signal
[ 240.906783] init: tty5 main process (452) killed by TERM signal
[ 240.908855] init: tty2 main process (453) killed by TERM signal
[ 240.911019] init: tty3 main process (454) killed by TERM signal
[ 240.913337] init: tty6 main process (455) killed by TERM signal
[ 240.919689] init: hwclock-save main process (458) terminated with status 70
[ 240.925065] init: plymouth-upstart-bridge main process (459) terminated with status 1
umount: /run/lock: not mounted
* Will now restart
[ 241.894718] Unregister pv shared memory for cpu 1
[ 241.895400] Unregister pv shared memory for cpu 0
[ 241.896170] spin_lock-torture: Unscheduled system shutdown detected
[ 241.912745] torture thread torture_stutter parking due to system shutdown
[ 241.914156] torture thread torture_shuffle parking due to system shutdown
[ 241.940045] reboot: Restarting system
[ 241.940598] reboot: machine restart

Elapsed time: 250

kvm=(
qemu-system-x86_64
-enable-kvm
-cpu kvm64
-kernel /pkg/linux/i386-randconfig-i0-201739/gcc-4.8/c394639389261e631779eb1ac94aaf1d16f566a5/vmlinuz-4.14.0-rc3-00002-gc394639
-initrd /osimage/quantal/quantal-core-i386.cgz
-m 399
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-watchdog-action debug
-rtc base=localtime
-drive file=/fs/sdc1/disk0-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk1-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk2-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk3-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk4-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk5-quantal-vp-31,media=disk,if=virtio
-drive file=/fs/sdc1/disk6-quantal-vp-31,media=disk,if=virtio
-pidfile /dev/shm/kboot/pid-quantal-vp-31
-serial file:/dev/shm/kboot/quantal-vp-31/serial
-serial file:/dev/shm/kboot/quantal-vp-31/kmsg
-daemonize
-display none
-monitor null
)

append=(
root=/dev/ram0
hung_task_panic=1
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
drbd.minor_count=8
systemd.log_level=err
ignore_loglevel
console=tty0
earlyprintk=ttyS0,115200
console=ttyS0,115200
vga=normal
rw
link=/kbuild-tests/run-queue/kvm/i386-randconfig-i0-201739/wfg:unwind_frame-josh:c394639389261e631779eb1ac94aaf1d16f566a5/.vmlinuz-c394639389261e631779eb1ac94aaf1d16f566a5-20171009220139-265:quantal-vp-31
branch=wfg/unwind_frame-josh
BOOT_IMAGE=/pkg/linux/i386-randconfig-i0-201739/gcc-4.8/c394639389261e631779eb1ac94aaf1d16f566a5/vmlinuz-4.14.0-rc3-00002-gc394639
drbd.minor_count=8
)

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