15:43 mchp-pv@mchp-pv ~/Parthiban_V/kernel_test_robot/lkp-tests $ sudo bin/lkp qemu -k bzImage job-script result_root: /home/mchp-pv/.lkp//result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/20 downloading initrds ... /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 https://download.01.org/0day-ci/lkp-qemu/osimage/yocto/yocto-x86_64-minimal-20190520.cgz -N -P /home/mchp-pv/.lkp/cache/osimage/yocto 19270 blocks /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 https://download.01.org/0day-ci/lkp-qemu/osimage/pkg/debian-x86_64-20180403.cgz/trinity-static-x86_64-x86_64-1c734c75-1_2020-01-06.cgz -N -P /home/mchp-pv/.lkp/cache/osimage/pkg/debian-x86_64-20180403.cgz 43381 blocks Formatting '/tmp/vdisk-root/disk-vm-snb-118-0', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-1', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-2', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-3', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-4', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-5', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 Formatting '/tmp/vdisk-root/disk-vm-snb-118-6', fmt=qcow2 size=274877906944 cluster_size=65536 lazy_refcounts=off refcount_bits=16 exec command: qemu-system-x86_64 -enable-kvm -fsdev local,id=test_dev,path=/home/mchp-pv/.lkp//result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/20,security_model=none -device virtio-9p-pci,fsdev=test_dev,mount_tag=9p/virtfs_mount -kernel bzImage -append root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-118/trinity-300s-yocto-x86_64-minimal-20190520.cgz-05b35e7eb9a11bbe8102836965e634c04e712c88-20200902-7487-e3bsfy-161.yaml ARCH=x86_64 kconfig=x86_64-rhel-7.6-kselftests branch=linux-next/master commit=05b35e7eb9a11bbe8102836965e634c04e712c88 BOOT_IMAGE=/pkg/linux/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/vmlinuz-5.9.0-rc1-00605-g05b35e7eb9a11 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/274 LKP_LOCAL_RUN=1 selinux=0 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 ip=dhcp result_service=9p/virtfs_mount -initrd /home/mchp-pv/.lkp/cache/final_initrd -smp 2 -m 7187M -no-reboot -watchdog i6300esb -rtc base=localtime -device e1000,netdev=net0 -netdev user,id=net0 -display none -monitor null -serial stdio -drive file=/tmp/vdisk-root/disk-vm-snb-118-0,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-1,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-2,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-3,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-4,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-5,media=disk,if=virtio -drive file=/tmp/vdisk-root/disk-vm-snb-118-6,media=disk,if=virtio qemu-system-x86_64: warning: host doesn't support requested feature: CPUID.80000001H:ECX.svm [bit 2] qemu-system-x86_64: warning: host doesn't support requested feature: CPUID.80000001H:ECX.svm [bit 2] early console in setup code Probing EDD (edd=off to disable)... ok Wrong EFI loader signature. early console in extract_kernel input_data: 0x00000000047353a8 input_len: 0x0000000000c53278 output: 0x0000000001000000 output_len: 0x0000000004324b84 kernel_total_size: 0x000000000382c000 needed_size: 0x0000000004400000 trampoline_32bit: 0x000000000009d000 booted via startup_32() Physical KASLR using RDTSC... Virtual KASLR using RDTSC... Decompressing Linux... Parsing ELF... Performing relocations... done. Booting the kernel. [ 0.000000] Linux version 5.9.0-rc1-00605-g05b35e7eb9a1 (mchp-pv@mchp-pv.mchp-main.com) (gcc (Ubuntu 7.5.0-3ubuntu1~18.04) 7.5.0, GNU ld (GNU Binutils for Ubuntu) 2.30) #19 SMP PREEMPT Wed Sep 23 14:24:33 IST 2020 [ 0.000000] Command line: root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-118/trinity-300s-yocto-x86_64-minimal-20190520.cgz-05b35e7eb9a11bbe8102836965e634c04e712c88-20200902-7487-e3bsfy-161.yaml ARCH=x86_64 kconfig=x86_64-rhel-7.6-kselftests branch=linux-next/master commit=05b35e7eb9a11bbe8102836965e634c04e712c88 BOOT_IMAGE=/pkg/linux/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/vmlinuz-5.9.0-rc1-00605-g05b35e7eb9a11 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/274 LKP_LOCAL_RUN=1 selinux=0 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 ip=dhcp result_se [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] 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-0x00000000bffd1fff] usable [ 0.000000] BIOS-e820: [mem 0x00000000bffd2000-0x00000000bfffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x00000002012fffff] usable [ 0.000000] printk: debug: ignoring loglevel setting. [ 0.000000] printk: 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.10.2-1ubuntu1 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000001] kvm-clock: cpu 0, msr 161201001, primary cpu clock [ 0.000001] kvm-clock: using sched offset of 359907962 cycles [ 0.000908] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.003365] tsc: Detected 3092.972 MHz processor [ 0.004967] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.006123] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.006988] last_pfn = 0x201300 max_arch_pfn = 0x400000000 [ 0.007879] MTRR default type: write-back [ 0.008500] MTRR fixed ranges enabled: [ 0.009080] 00000-9FFFF write-back [ 0.009632] A0000-BFFFF uncachable [ 0.010184] C0000-FFFFF write-protect [ 0.010775] MTRR variable ranges enabled: [ 0.011395] 0 base 00C0000000 mask FFC0000000 uncachable [ 0.012244] 1 disabled [ 0.012634] 2 disabled [ 0.013025] 3 disabled [ 0.013417] 4 disabled [ 0.013807] 5 disabled [ 0.014198] 6 disabled [ 0.014590] 7 disabled [ 0.014996] x86/PAT: PAT not supported by the CPU. [ 0.015755] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC Memory KASLR using RDTSC... [ 0.017175] last_pfn = 0xbffd2 max_arch_pfn = 0x400000000 [ 0.017988] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.018811] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.019654] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.030693] found SMP MP-table at [mem 0x000f6a40-0x000f6a4f] [ 0.031683] mpc: f6a50-f6b74 [ 0.033236] RAMDISK: [mem 0x7f9df000-0x7fffffff] [ 0.033980] ACPI: Early table checksum verification disabled [ 0.034866] ACPI: RSDP 0x00000000000F6800 000014 (v00 BOCHS ) [ 0.035803] ACPI: RSDT 0x00000000BFFE1656 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.037127] ACPI: FACP 0x00000000BFFE14AA 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.038450] ACPI: DSDT 0x00000000BFFE0040 00146A (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.039775] ACPI: FACS 0x00000000BFFE0000 000040 [ 0.040470] ACPI: APIC 0x00000000BFFE159E 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.041749] ACPI: HPET 0x00000000BFFE161E 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.043035] ACPI: Local APIC address 0xfee00000 [ 0.043748] mapped APIC to ffffffffff5fc000 ( fee00000) [ 0.044983] No NUMA configuration found [ 0.045644] Faking a node at [mem 0x0000000000000000-0x00000002012fffff] [ 0.046690] NODE_DATA(0) allocated [mem 0x2012d5000-0x2012fffff] [ 0.048106] Zone ranges: [ 0.048497] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.049453] DMA32 [mem 0x0000000001000000-0x00000000ffffffff] [ 0.050406] Normal [mem 0x0000000100000000-0x00000002012fffff] [ 0.051360] Device empty [ 0.051810] Movable zone start for each node [ 0.052471] Early memory node ranges [ 0.053024] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.053988] node 0: [mem 0x0000000000100000-0x00000000bffd1fff] [ 0.054928] node 0: [mem 0x0000000100000000-0x00000002012fffff] [ 0.056821] Zeroed struct page in unavailable ranges: 28048 pages [ 0.056825] Initmem setup node 0 [mem 0x0000000000001000-0x00000002012fffff] [ 0.059002] On node 0 totalpages: 1839728 [ 0.059634] DMA zone: 64 pages used for memmap [ 0.060347] DMA zone: 21 pages reserved [ 0.060965] DMA zone: 3998 pages, LIFO batch:0 [ 0.061715] DMA32 zone: 12224 pages used for memmap [ 0.062500] DMA32 zone: 782290 pages, LIFO batch:63 [ 0.074061] Normal zone: 16460 pages used for memmap [ 0.075034] Normal zone: 1053440 pages, LIFO batch:63 [ 0.077030] ACPI: PM-Timer IO Port: 0x608 [ 0.077655] ACPI: Local APIC address 0xfee00000 [ 0.078374] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.079323] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.080389] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.081378] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.082494] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.083522] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.084636] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.085657] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.086775] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.087829] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.088944] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.090007] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.091224] ACPI: IRQ0 used by override. [ 0.091830] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.092940] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.094052] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.095167] ACPI: IRQ5 used by override. [ 0.095783] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.096876] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.097954] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.099032] ACPI: IRQ9 used by override. [ 0.099648] ACPI: IRQ10 used by override. [ 0.100246] ACPI: IRQ11 used by override. [ 0.100976] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.102092] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.103208] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.104326] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.105442] Using ACPI (MADT) for SMP configuration information [ 0.106358] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.107167] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.107936] mapped IOAPIC to ffffffffff5fb000 (fec00000) [ 0.108777] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.109914] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.111047] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.112202] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.113452] PM: hibernation: Registered nosave memory: [mem 0xbffd2000-0xbfffffff] [ 0.114618] PM: hibernation: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] [ 0.115790] PM: hibernation: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] [ 0.116957] PM: hibernation: Registered nosave memory: [mem 0xff000000-0xfffbffff] [ 0.118124] PM: hibernation: Registered nosave memory: [mem 0xfffc0000-0xffffffff] [ 0.119295] [mem 0xc0000000-0xfeffbfff] available for PCI devices [ 0.120238] Booting paravirtualized kernel on KVM [ 0.120970] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.127972] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.129563] percpu: Embedded 58 pages/cpu s200704 r8192 d28672 u1048576 [ 0.130572] pcpu-alloc: s200704 r8192 d28672 u1048576 alloc=1*2097152 [ 0.131562] pcpu-alloc: [0] 0 1 [ 0.132082] kvm-guest: stealtime: cpu 0, msr 1f9c30080 [ 0.132878] kvm-guest: PV spinlocks disabled, no host support [ 0.133780] Built 1 zonelists, mobility grouping on. Total pages: 1810959 [ 0.134840] Policy zone: Normal [ 0.135326] Kernel command line: root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-118/trinity-300s-yocto-x86_64-minimal-20190520.cgz-05b35e7eb9a11bbe8102836965e634c04e712c88-20200902-7487-e3bsfy-161.yaml ARCH=x86_64 kconfig=x86_64-rhel-7.6-kselftests branch=linux-next/master commit=05b35e7eb9a11bbe8102836965e634c04e712c88 BOOT_IMAGE=/pkg/linux/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/vmlinuz-5.9.0-rc1-00605-g05b35e7eb9a11 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/274 LKP_LOCAL_RUN=1 selinux=0 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 ip=dhcp re [ 0.135578] sysrq: sysrq always enabled. [ 0.149694] ignoring the deprecated load_ramdisk= option [ 0.151895] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes, linear) [ 0.153777] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) [ 0.155079] mem auto-init: stack:off, heap alloc:off, heap free:off [ 0.190834] Memory: 3204068K/7358912K available (16390K kernel code, 3642K rwdata, 9084K rodata, 2608K init, 17584K bss, 259404K reserved, 0K cma-reserved) [ 0.193364] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.194415] Kernel/User page tables isolation: enabled [ 0.195270] ftrace: allocating 49298 entries in 193 pages [ 0.215148] ftrace: allocated 193 pages with 3 groups [ 0.216375] Running RCU self tests [ 0.216914] rcu: Preemptible hierarchical RCU implementation. [ 0.217770] rcu: RCU lockdep checking is enabled. [ 0.218483] rcu: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=2. [ 0.219511] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). [ 0.220595] Trampoline variant of Tasks RCU enabled. [ 0.221346] Rude variant of Tasks RCU enabled. [ 0.222019] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [ 0.223152] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.227368] NR_IRQS: 524544, nr_irqs: 440, preallocated irqs: 16 [ 0.228713] random: get_random_bytes called from start_kernel+0x38f/0x57b with crng_init=0 [ 0.236686] Console: colour VGA+ 80x25 [ 0.343007] printk: console [tty0] enabled [ 0.344268] printk: console [ttyS0] enabled [ 0.344268] printk: console [ttyS0] enabled [ 0.346031] printk: bootconsole [earlyser0] disabled [ 0.346031] printk: bootconsole [earlyser0] disabled [ 0.348066] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.350128] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.351235] ... MAX_LOCK_DEPTH: 48 [ 0.352432] ... MAX_LOCKDEP_KEYS: 8192 [ 0.353592] ... CLASSHASH_SIZE: 4096 [ 0.354744] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.355920] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.357072] ... CHAINHASH_SIZE: 32768 [ 0.358308] memory used by lock dependency info: 6301 kB [ 0.359677] memory used for stack traces: 4224 kB [ 0.360903] per task-struct memory footprint: 1920 bytes [ 0.362295] ACPI: Core revision 20200717 [ 0.363577] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.366052] APIC: Switch to symmetric I/O mode setup [ 0.367699] x2apic enabled [ 0.368916] Switched APIC routing to physical x2apic. [ 0.370230] masked ExtINT on CPU#0 [ 0.372524] ENABLING IO-APIC IRQs [ 0.373493] init IO_APIC IRQs [ 0.374372] apic 0 pin 0 not connected [ 0.375448] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:0) [ 0.377478] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:0) [ 0.379481] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:0) [ 0.381477] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:0) [ 0.383491] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:0) [ 0.385496] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:0) [ 0.387505] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:0) [ 0.389507] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:0) [ 0.391595] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:0) [ 0.393599] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:0) [ 0.395668] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:0) [ 0.397725] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:0) [ 0.399802] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:0) [ 0.401896] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:0) [ 0.404018] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:0) [ 0.406110] apic 0 pin 16 not connected [ 0.407166] apic 0 pin 17 not connected [ 0.408217] apic 0 pin 18 not connected [ 0.409266] apic 0 pin 19 not connected [ 0.410312] apic 0 pin 20 not connected [ 0.411375] apic 0 pin 21 not connected [ 0.412539] apic 0 pin 22 not connected [ 0.413607] apic 0 pin 23 not connected [ 0.414793] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.416310] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x2c955856658, max_idle_ns: 440795256416 ns [ 0.418866] Calibrating delay loop (skipped) preset value.. 6185.94 BogoMIPS (lpj=3092972) [ 0.419861] pid_max: default: 32768 minimum: 301 [ 0.420903] LSM: Security Framework initializing [ 0.421864] Yama: becoming mindful. [ 0.422905] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) [ 0.424116] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes, linear) Poking KASLR using RDTSC... [ 0.426098] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.426861] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.427864] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization [ 0.428863] Spectre V2 : Mitigation: Full generic retpoline [ 0.429860] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch [ 0.430860] Speculative Store Bypass: Vulnerable [ 0.431864] MDS: Vulnerable: Clear CPU buffers attempted, no microcode [ 0.433106] Freeing SMP alternatives memory: 40K [ 0.435332] Using local APIC timer interrupts. [ 0.435332] calibrating APIC timer ... [ 0.538341] ... lapic delta = 6250000 [ 0.538857] ... PM-Timer delta = 357953 [ 0.538857] ... PM-Timer result ok [ 0.538857] ..... delta 6250000 [ 0.538857] ..... mult: 268435456 [ 0.538857] ..... calibration result: 1000000 [ 0.538857] ..... CPU clock speed is 3092.0961 MHz. [ 0.538857] ..... host bus clock speed is 1000.0000 MHz. [ 0.538902] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3) [ 0.540236] Performance Events: PMU not available due to virtualization, using software events only. [ 0.541894] rcu: Hierarchical SRCU implementation. [ 0.543239] NMI watchdog: Perf NMI watchdog permanently disabled [ 0.544099] smp: Bringing up secondary CPUs ... [ 0.545318] x86: Booting SMP configuration: [ 0.545883] .... node #0, CPUs: #1 [ 0.186215] kvm-clock: cpu 1, msr 161201041, secondary cpu clock [ 0.186215] masked ExtINT on CPU#1 [ 0.186215] smpboot: CPU 1 Converting physical 0 to logical die 1 [ 0.549944] kvm-guest: stealtime: cpu 1, msr 1f9d30080 [ 0.550929] smp: Brought up 1 node, 2 CPUs [ 0.551879] smpboot: Max logical packages: 2 [ 0.552868] smpboot: Total of 2 processors activated (12371.88 BogoMIPS) [ 0.565885] node 0 deferred pages initialised in 12ms [ 0.568137] devtmpfs: initialized [ 0.569024] x86/mm: Memory block size: 128MB [ 0.573952] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.574873] futex hash table entries: 512 (order: 4, 65536 bytes, linear) [ 0.576069] pinctrl core: initialized pinctrl subsystem [ 0.577862] PM: RTC time: 15:43:29, date: 2020-09-23 [ 0.579228] NET: Registered protocol family 16 [ 0.581082] DMA: preallocated 1024 KiB GFP_KERNEL pool for atomic allocations [ 0.581872] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [ 0.582870] DMA: preallocated 1024 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [ 0.583889] audit: initializing netlink subsys (disabled) [ 0.585244] thermal_sys: Registered thermal governor 'fair_share' [ 0.585245] thermal_sys: Registered thermal governor 'bang_bang' [ 0.585875] thermal_sys: Registered thermal governor 'step_wise' [ 0.585893] audit: type=2000 audit(1600856008.861:1): state=initialized audit_enabled=0 res=1 [ 0.586864] thermal_sys: Registered thermal governor 'user_space' [ 0.591891] cpuidle: using governor menu [ 0.594177] ACPI: bus type PCI registered [ 0.594863] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.596106] PCI: Using configuration type 1 for base access [ 0.604971] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.609953] ACPI: Added _OSI(Module Device) [ 0.610892] ACPI: Added _OSI(Processor Device) [ 0.611863] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.612862] ACPI: Added _OSI(Processor Aggregator Device) [ 0.613864] ACPI: Added _OSI(Linux-Dell-Video) [ 0.614863] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 0.615870] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 0.619292] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.621911] ACPI: Interpreter enabled [ 0.622900] ACPI: (supports S0 S3 S4 S5) [ 0.623863] ACPI: Using IOAPIC for interrupt routing [ 0.624890] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.626999] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.635965] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.636868] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] [ 0.637928] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.640876] acpiphp: Slot [3] registered [ 0.641905] acpiphp: Slot [4] registered [ 0.642903] acpiphp: Slot [5] registered [ 0.643903] acpiphp: Slot [6] registered [ 0.644903] acpiphp: Slot [7] registered [ 0.645919] acpiphp: Slot [8] registered [ 0.646905] acpiphp: Slot [9] registered [ 0.647908] acpiphp: Slot [10] registered [ 0.648905] acpiphp: Slot [11] registered [ 0.649905] acpiphp: Slot [12] registered [ 0.650906] acpiphp: Slot [13] registered [ 0.651903] acpiphp: Slot [14] registered [ 0.652904] acpiphp: Slot [15] registered [ 0.653917] acpiphp: Slot [16] registered [ 0.654905] acpiphp: Slot [17] registered [ 0.655906] acpiphp: Slot [18] registered [ 0.656903] acpiphp: Slot [19] registered [ 0.657908] acpiphp: Slot [20] registered [ 0.658912] acpiphp: Slot [21] registered [ 0.659905] acpiphp: Slot [22] registered [ 0.660908] acpiphp: Slot [23] registered [ 0.661915] acpiphp: Slot [24] registered [ 0.662905] acpiphp: Slot [25] registered [ 0.663905] acpiphp: Slot [26] registered [ 0.664907] acpiphp: Slot [27] registered [ 0.665905] acpiphp: Slot [28] registered [ 0.666903] acpiphp: Slot [29] registered [ 0.668892] acpiphp: Slot [30] registered [ 0.669904] acpiphp: Slot [31] registered [ 0.670883] PCI host bridge to bus 0000:00 [ 0.671864] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.672863] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.673863] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.674864] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] [ 0.675863] pci_bus 0000:00: root bus resource [mem 0x240000000-0x2bfffffff window] [ 0.676864] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.678929] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.681366] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.682965] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.687408] pci 0000:00:01.1: reg 0x20: [io 0xc240-0xc24f] [ 0.689802] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.689863] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.690863] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.691868] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.693959] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.696148] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.696875] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.698370] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 0.700884] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 0.704884] pci 0000:00:02.0: reg 0x18: [mem 0xfebb0000-0xfebb0fff] [ 0.713549] pci 0000:00:02.0: reg 0x30: [mem 0xfeba0000-0xfebaffff pref] [ 0.715567] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 [ 0.717644] pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc03f] [ 0.718864] pci 0000:00:03.0: reg 0x14: [mem 0xfebb1000-0xfebb1fff] [ 0.724867] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] [ 0.729059] pci 0000:00:04.0: [8086:100e] type 00 class 0x020000 [ 0.731374] pci 0000:00:04.0: reg 0x10: [mem 0xfeb80000-0xfeb9ffff] [ 0.733379] pci 0000:00:04.0: reg 0x14: [io 0xc040-0xc07f] [ 0.739407] pci 0000:00:04.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref] [ 0.741174] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000 [ 0.745636] pci 0000:00:05.0: reg 0x10: [io 0xc080-0xc0bf] [ 0.747640] pci 0000:00:05.0: reg 0x14: [mem 0xfebb2000-0xfebb2fff] [ 0.752871] pci 0000:00:05.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] [ 0.758170] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 [ 0.760864] pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0ff] [ 0.763866] pci 0000:00:06.0: reg 0x14: [mem 0xfebb3000-0xfebb3fff] [ 0.769696] pci 0000:00:06.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] [ 0.772920] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 [ 0.775864] pci 0000:00:07.0: reg 0x10: [io 0xc100-0xc13f] [ 0.777864] pci 0000:00:07.0: reg 0x14: [mem 0xfebb4000-0xfebb4fff] [ 0.783867] pci 0000:00:07.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref] [ 0.788257] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 [ 0.790645] pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f] [ 0.792685] pci 0000:00:08.0: reg 0x14: [mem 0xfebb5000-0xfebb5fff] [ 0.798868] pci 0000:00:08.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref] [ 0.803005] pci 0000:00:09.0: [1af4:1001] type 00 class 0x010000 [ 0.805864] pci 0000:00:09.0: reg 0x10: [io 0xc180-0xc1bf] [ 0.808865] pci 0000:00:09.0: reg 0x14: [mem 0xfebb6000-0xfebb6fff] [ 0.814677] pci 0000:00:09.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref] [ 0.818403] pci 0000:00:0a.0: [1af4:1001] type 00 class 0x010000 [ 0.820701] pci 0000:00:0a.0: reg 0x10: [io 0xc1c0-0xc1ff] [ 0.822626] pci 0000:00:0a.0: reg 0x14: [mem 0xfebb7000-0xfebb7fff] [ 0.827866] pci 0000:00:0a.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref] [ 0.832961] pci 0000:00:0b.0: [1af4:1001] type 00 class 0x010000 [ 0.835864] pci 0000:00:0b.0: reg 0x10: [io 0xc200-0xc23f] [ 0.838863] pci 0000:00:0b.0: reg 0x14: [mem 0xfebb8000-0xfebb8fff] [ 0.844866] pci 0000:00:0b.0: reg 0x20: [mem 0xfe01c000-0xfe01ffff 64bit pref] [ 0.849017] pci 0000:00:0c.0: [8086:25ab] type 00 class 0x088000 [ 0.851152] pci 0000:00:0c.0: reg 0x10: [mem 0xfebb9000-0xfebb900f] [ 0.857055] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.858062] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.860068] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.861056] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.861962] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.864020] iommu: Default domain type: Translated [ 0.865930] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 0.866857] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 0.866868] pci 0000:00:02.0: vgaarb: bridge control possible [ 0.867863] vgaarb: loaded [ 0.869949] SCSI subsystem initialized [ 0.870952] ACPI: bus type USB registered [ 0.871938] usbcore: registered new interface driver usbfs [ 0.873894] usbcore: registered new interface driver hub [ 0.874908] usbcore: registered new device driver usb [ 0.876897] pps_core: LinuxPPS API ver. 1 registered [ 0.877862] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.878870] PTP clock support registered [ 0.879915] EDAC MC: Ver: 3.0.0 [ 0.882354] NetLabel: Initializing [ 0.882862] NetLabel: domain hash size = 128 [ 0.883862] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 0.884911] NetLabel: unlabeled traffic allowed by default [ 0.885868] PCI: Using ACPI for IRQ routing [ 0.886862] PCI: pci_cache_line_size set to 64 bytes [ 0.888176] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.888874] e820: reserve RAM buffer [mem 0xbffd2000-0xbfffffff] [ 0.889863] e820: reserve RAM buffer [mem 0x201300000-0x203ffffff] [ 0.891878] hpet: 3 channels of 0 reserved for per-cpu timers [ 0.892877] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.893862] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.899986] clocksource: Switched to clocksource kvm-clock [ 0.971941] VFS: Disk quotas dquot_6.6.0 [ 0.973196] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.975261] pnp: PnP ACPI init [ 0.976393] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.978174] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.979944] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.981692] pnp 00:03: [dma 2] [ 0.982647] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.984498] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.986298] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.988430] pnp: PnP ACPI: found 6 devices [ 1.000335] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 1.002974] NET: Registered protocol family 2 [ 1.004772] tcp_listen_portaddr_hash hash table entries: 4096 (order: 6, 327680 bytes, linear) [ 1.007229] TCP established hash table entries: 65536 (order: 7, 524288 bytes, linear) [ 1.010068] TCP bind hash table entries: 65536 (order: 10, 4718592 bytes, vmalloc) [ 1.014272] TCP: Hash tables configured (established 65536 bind 65536) [ 1.016505] MPTCP token hash table entries: 8192 (order: 7, 720896 bytes, linear) [ 1.018785] UDP hash table entries: 4096 (order: 7, 655360 bytes, linear) [ 1.021114] UDP-Lite hash table entries: 4096 (order: 7, 655360 bytes, linear) [ 1.023404] NET: Registered protocol family 1 [ 1.025278] RPC: Registered named UNIX socket transport module. [ 1.027016] RPC: Registered udp transport module. [ 1.028314] RPC: Registered tcp transport module. [ 1.031289] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 1.033107] NET: Registered protocol family 44 [ 1.034338] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.035992] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.037624] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.039404] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] [ 1.041177] pci_bus 0000:00: resource 8 [mem 0x240000000-0x2bfffffff window] [ 1.043091] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.044637] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.046191] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.047904] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 1.050387] PCI: CLS 0 bytes, default 64 [ 1.051852] Trying to unpack rootfs image as initramfs... [ 1.292222] Freeing initrd memory: 6276K [ 1.293581] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) [ 1.295395] software IO TLB: mapped [mem 0xbbfd2000-0xbffd2000] (64MB) [ 1.298401] kvm: already loaded the other module [ 1.299797] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2c955856658, max_idle_ns: 440795256416 ns [ 1.304044] Initialise system trusted keyrings [ 1.305413] Key type blacklist registered [ 1.306708] workingset: timestamp_bits=36 max_order=21 bucket_order=0 [ 1.314453] zbud: loaded [ 1.316166] 9p: Installing v9fs 9p2000 file system support [ 1.327118] NET: Registered protocol family 38 [ 1.328525] Key type asymmetric registered [ 1.329747] Asymmetric key parser 'x509' registered [ 1.331123] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) [ 1.333315] io scheduler mq-deadline registered [ 1.334561] io scheduler kyber registered [ 1.335912] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 1.337759] start plist test [ 1.339750] end plist test [ 1.340745] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 1.342960] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 1.352127] ACPI: Power Button [PWRF] [ 1.462008] PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 1.572333] PCI Interrupt Link [LNKA] enabled at IRQ 10 [ 1.682562] PCI Interrupt Link [LNKB] enabled at IRQ 10 [ 1.900359] PCI Interrupt Link [LNKD] enabled at IRQ 11 [ 2.227536] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 2.229551] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 2.232950] Non-volatile memory driver v1.3 [ 2.234215] Linux agpgart interface v0.103 [ 2.236291] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 0 [ 2.239649] virtio_blk virtio1: [vda] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.241925] vda: detected capacity change from 0 to 274877906944 [ 2.246652] virtio_blk virtio2: [vdb] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.248899] vdb: detected capacity change from 0 to 274877906944 [ 2.253684] virtio_blk virtio3: [vdc] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.256325] vdc: detected capacity change from 0 to 274877906944 [ 2.260598] virtio_blk virtio4: [vdd] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.262935] vdd: detected capacity change from 0 to 274877906944 [ 2.267338] virtio_blk virtio5: [vde] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.269333] vde: detected capacity change from 0 to 274877906944 [ 2.273372] virtio_blk virtio6: [vdf] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.275325] vdf: detected capacity change from 0 to 274877906944 [ 2.279221] virtio_blk virtio7: [vdg] 536870912 512-byte logical blocks (275 GB/256 GiB) [ 2.281227] vdg: detected capacity change from 0 to 274877906944 [ 2.284636] lkdtm: No crash points registered, enable through debugfs [ 2.286314] rdac: device handler registered [ 2.287525] hp_sw: device handler registered [ 2.288609] emc: device handler registered [ 2.289750] alua: device handler registered [ 2.291517] MACsec IEEE 802.1AE [ 2.292741] libphy: Fixed MDIO Bus: probed [ 2.294076] e1000: Intel(R) PRO/1000 Network Driver [ 2.295288] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 2.746227] e1000 0000:00:04.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 2.747977] e1000 0000:00:04.0 eth0: Intel(R) PRO/1000 Network Connection [ 2.749624] e1000e: Intel(R) PRO/1000 Network Driver [ 2.750837] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 2.752257] igb: Intel(R) Gigabit Ethernet Network Driver [ 2.753637] igb: Copyright (c) 2007-2014 Intel Corporation. [ 2.755090] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver [ 2.756511] ixgbe: Copyright (c) 1999-2016 Intel Corporation. [ 2.758155] i40e: Intel(R) Ethernet Connection XL710 Network Driver [ 2.759635] i40e: Copyright (c) 2013 - 2019 Intel Corporation. [ 2.761259] usbcore: registered new interface driver catc [ 2.762707] usbcore: registered new interface driver kaweth [ 2.764032] pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver [ 2.765852] usbcore: registered new interface driver pegasus [ 2.767188] usbcore: registered new interface driver rtl8150 [ 2.768622] usbcore: registered new interface driver asix [ 2.769934] usbcore: registered new interface driver cdc_ether [ 2.771330] usbcore: registered new interface driver cdc_eem [ 2.772693] usbcore: registered new interface driver dm9601 [ 2.774059] usbcore: registered new interface driver smsc75xx [ 2.775460] usbcore: registered new interface driver smsc95xx [ 2.776812] usbcore: registered new interface driver gl620a [ 2.778179] usbcore: registered new interface driver net1080 [ 2.779548] usbcore: registered new interface driver plusb [ 2.780952] usbcore: registered new interface driver rndis_host [ 2.782358] usbcore: registered new interface driver cdc_subset [ 2.783756] usbcore: registered new interface driver zaurus [ 2.785098] usbcore: registered new interface driver MOSCHIP usb-ethernet driver [ 2.786921] usbcore: registered new interface driver int51x1 [ 2.788276] usbcore: registered new interface driver ipheth [ 2.789614] usbcore: registered new interface driver sierra_net [ 2.791248] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 2.792765] ehci-pci: EHCI PCI platform driver [ 2.793914] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.795358] ohci-pci: OHCI PCI platform driver [ 2.796488] uhci_hcd: USB Universal Host Controller Interface driver [ 2.798090] usbcore: registered new interface driver usbserial_generic [ 2.799731] usbserial: USB Serial support registered for generic [ 2.801255] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 2.804138] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 2.805545] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 2.806994] mousedev: PS/2 mouse device common for all mice [ 2.809121] rtc_cmos 00:00: RTC can wake from S4 [ 2.810410] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 2.813744] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 [ 2.816255] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 2.819246] rtc_cmos 00:00: registered as rtc0 [ 2.820493] rtc_cmos 00:00: setting system clock to 2020-09-23T15:43:31 UTC (1600875811) [ 2.822600] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs [ 2.826189] i6300ESB timer 0000:00:0c.0: initialized. heartbeat=30 sec (nowayout=0) [ 2.828100] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11 [ 2.829454] iTCO_vendor_support: vendor-support=0 [ 2.830612] intel_pstate: CPU model not supported [ 2.832513] hid: raw HID events driver (C) Jiri Kosina [ 2.834088] usbcore: registered new interface driver usbhid [ 2.835483] usbhid: USB HID core driver [ 2.836758] drop_monitor: Initializing network drop monitor service [ 2.838321] netem: version 1.3 [ 2.839261] ipip: IPv4 and MPLS over IPv4 tunneling driver [ 2.840833] gre: GRE over IPv4 demultiplexor driver [ 2.842056] ip_gre: GRE over IPv4 tunneling driver [ 2.843814] Initializing XFRM netlink socket [ 2.845290] NET: Registered protocol family 10 [ 2.847368] Segment Routing with IPv6 [ 2.848634] ip6_gre: GRE over IPv6 tunneling driver [ 2.850135] NET: Registered protocol family 17 [ 2.851380] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. [ 2.854514] 8021q: 802.1Q VLAN Support v1.8 [ 2.855705] 9pnet: Installing 9P2000 support [ 2.858457] IPI shorthand broadcast: enabled [ 2.859575] ... APIC ID: 00000000 (0) [ 2.860568] ... APIC VERSION: 00050014 [ 2.860568] 0000000000000000000000000000000000000000000000000000000000000000 [ 2.860568] 0000000000000000000000000000000000000000000000000000000000000000 [ 2.860568] 0000000000000000000000000000000000000000000000000000000008000000 [ 2.868523] number of MP IRQ sources: 15. [ 2.869607] number of IO-APIC #0 registers: 24. [ 2.870821] testing the IO APIC....................... [ 2.872083] IO APIC #0...... [ 2.872906] .... register #00: 00000000 [ 2.873918] ....... : physical APIC id: 00 [ 2.875108] ....... : Delivery Type: 0 [ 2.876131] ....... : LTS : 0 [ 2.877167] .... register #01: 00170011 [ 2.878165] ....... : max redirection entries: 17 [ 2.879350] ....... : PRQ implemented: 0 [ 2.880442] ....... : IO APIC version: 11 [ 2.881575] .... register #02: 00000000 [ 2.882687] ....... : arbitration: 00 [ 2.883707] .... IRQ redirection table: [ 2.884695] IOAPIC 0: [ 2.887021] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.888927] pin01, enabled , edge , high, V(2C), IRR(0), S(0), physical, D(00), M(0) [ 2.890817] pin02, enabled , edge , high, V(30), IRR(0), S(0), physical, D(00), M(0) [ 2.892787] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.894727] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.896600] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.898507] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.900519] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.902431] pin08, enabled , edge , high, V(2D), IRR(0), S(0), physical, D(01), M(0) [ 2.904323] pin09, enabled , level, high, V(21), IRR(0), S(0), physical, D(01), M(0) [ 2.906223] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.908124] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.910120] pin0c, enabled , edge , high, V(2C), IRR(0), S(0), physical, D(01), M(0) [ 2.912023] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.914015] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.915989] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.917897] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.919810] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.921717] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.923616] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.925518] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.927419] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.929340] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.931354] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 2.933248] IRQ to pin mappings: [ 2.934117] IRQ0 -> 0:2 [ 2.934825] IRQ1 -> 0:1 [ 2.935549] IRQ3 -> 0:3 [ 2.936273] IRQ4 -> 0:4 [ 2.936995] IRQ5 -> 0:5 [ 2.937709] IRQ6 -> 0:6 [ 2.938424] IRQ7 -> 0:7 [ 2.939146] IRQ8 -> 0:8 [ 2.939855] IRQ9 -> 0:9 [ 2.940575] IRQ10 -> 0:10 [ 2.941334] IRQ11 -> 0:11 [ 2.942089] IRQ12 -> 0:12 [ 2.942820] IRQ13 -> 0:13 [ 2.943660] IRQ14 -> 0:14 [ 2.944417] IRQ15 -> 0:15 [ 2.945174] .................................... done. [ 2.946444] sched_clock: Marking stable (2761185987, 185215144)->(3076627914, -130226783) [ 2.948653] registered taskstats version 1 [ 2.949730] Loading compiled-in X.509 certificates [ 2.952419] Loaded X.509 cert 'Build time autogenerated kernel key: 343ee5f582a9826ae84355edfc7ff7627ab56ad0' [ 2.954803] zswap: loaded using pool lzo/zbud [ 2.961138] Key type encrypted registered [ 2.962259] ima: No TPM chip found, activating TPM-bypass! [ 2.963589] ima: Allocated hash algorithm: sha1 [ 2.964742] ima: No architecture policies found [ 2.965964] evm: Initialising EVM extended attributes: [ 2.967308] evm: security.selinux [ 2.968199] evm: security.ima [ 2.969020] evm: security.capability [ 2.969964] evm: HMAC attrs: 0x1 [ 2.971569] PM: Magic number: 4:24:741 [ 2.972648] workqueue writeback: hash matches [ 2.979117] 8021q: adding VLAN 0 to HW filter on device eth0 [ 2.980680] IP-Config: Failed to open gretap0 [ 2.981787] IP-Config: Failed to open erspan0 [ 2.994939] Sending DHCP requests . [ 4.989676] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX [ 4.996200] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 5.216979] ., OK [ 5.219068] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15 [ 5.222212] IP-Config: Complete: [ 5.223851] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2 [ 5.226747] host=10.0.2.15, domain=, nis-domain=(none) [ 5.228077] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath= [ 5.228078] nameserver0=10.0.2.3 [ 5.235578] Freeing unused decrypted memory: 2040K [ 5.238125] Freeing unused kernel image (initmem) memory: 2608K [ 5.239812] Write protecting the kernel read-only data: 28672k [ 5.242940] Freeing unused kernel image (text/rodata gap) memory: 2040K [ 5.244882] Freeing unused kernel image (rodata/data gap) memory: 1156K [ 5.246537] rodata_test: all tests were successful [ 5.254041] Run /init as init process [ 5.255047] with arguments: [ 5.255924] /init [ 5.256610] with environment: [ 5.257481] HOME=/ [ 5.258195] TERM=linux [ 5.258972] user=$(whoami) [ 5.259801] job=/lkp/jobs/scheduled/vm-snb-118/trinity-300s-yocto-x86_64-minimal-20190520.cgz-05b35e7eb9a11bbe8102836965e634c04e712c88-20200902-7487-e3bsfy-161.yaml [ 5.263627] ARCH=x86_64 [ 5.264570] kconfig=x86_64-rhel-7.6-kselftests [ 5.265974] branch=linux-next/master [ 5.267212] commit=05b35e7eb9a11bbe8102836965e634c04e712c88 [ 5.268870] BOOT_IMAGE=/pkg/linux/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/vmlinuz-5.9.0-rc1-00605-g05b35e7eb9a11 [ 5.272410] max_uptime=1500 [ 5.273410] RESULT_ROOT=/result/trinity/300s/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-rhel-7.6-kselftests/gcc-9/05b35e7eb9a11bbe8102836965e634c04e712c88/274 [ 5.276715] LKP_LOCAL_RUN=1 [ 5.277587] softlockup_panic=1 [ 5.278494] prompt_ramdisk=0 [ 5.279345] vga=normal [ 5.280100] result_service=9p/virtfs_mount INIT: version 2.88 booting Starting udev [ 5.343750] udevd[135]: starting version 3.2.7 [ 5.345377] random: udevd: uninitialized urandom read (16 bytes read) [ 5.347028] random: udevd: uninitialized urandom read (16 bytes read) [ 5.348553] random: udevd: uninitialized urandom read (16 bytes read) [ 5.351387] udevd[135]: specified group 'kvm' unknown [ 5.354576] udevd[136]: starting eudev-3.2.7 [ 5.378262] udevd[136]: specified group 'kvm' unknown [ 5.429388] random: fast init done depmod: ERROR: could not open directory /lib/modules/5.9.0-rc1-00605-g05b35e7eb9a1: No such file or directory depmod: WARNING: -e needs -E or -F depmod: ERROR: could not open directory /lib/modules/5.9.0-rc1-00605-g05b35e7eb9a1: No such file or directory depmod: FATAL: could not search modules: No such file or directory [ 6.669157] urandom_read: 4 callbacks suppressed [ 6.669160] random: dd: uninitialized urandom read (512 bytes read) INIT: Entering runlevel: 5 Configuring network interfaces... ip: RTNETLINK answers: File exists Starting syslogd/klogd: done /etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-118/trinity-300s-yocto-x86_64-minimal-20190520.cgz-05b35e7eb9a11bbe8102836965e634c04e712c88-20200902-7487-e3bsfy-161.sh: line 129: start: not found PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lkp/root/src/bin LKP: HOSTNAME vm-snb-118, MAC c6:87:08:35:85:2d, kernel 5.9.0-rc1-00605-g05b35e7eb9a1 19, serial console /dev/ttyS0 Poky (Yocto Project Reference Distro) 2.7+snapshot vm-snb-118 /dev/ttyS0 INIT: Id "S1" respawning too fast: disabled for 5 minutes [ 18.705713] trinity-main uses obsolete (PF_INET,SOCK_PACKET) [ 20.496019] random: crng init done [ 20.501616] raw_sendmsg: trinity-c0 forgot to set AF_INET. Fix it! [ 20.546766] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary. [ 20.965683] trinity-c1 (846): attempted to duplicate a private mapping with mremap. This is not supported. [ 21.040587] VFS: Warning: trinity-c1 using old stat() call. Recompile your binary. [ 21.091814] VFS: Warning: trinity-c1 using old stat() call. Recompile your binary. [ 21.554599] VFS: Warning: trinity-c0 using old stat() call. Recompile your binary. [ 22.964665] audit: type=1326 audit(1600875831.246:2): auid=4294967295 uid=555450368 gid=0 ses=4294967295 pid=824 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 23.010580] audit: type=1326 audit(1600875831.294:3): auid=4294967295 uid=536887296 gid=33695232 ses=4294967295 pid=901 comm="trinity-c3" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 23.028342] Unable to find swap-space signature [ 23.654068] VFS: Warning: trinity-c5 using old stat() call. Recompile your binary. [ 27.789432] warning: process `trinity-c0' used the obsolete bdflush system call [ 27.791475] Fix your initscripts? [ 29.930344] warning: process `trinity-c4' used the obsolete bdflush system call [ 29.932348] Fix your initscripts? [ 32.030009] audit: type=1326 audit(1600875840.313:4): auid=4294967295 uid=8388608 gid=0 ses=4294967295 pid=1072 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 32.983957] audit: type=1326 audit(1600875841.267:5): auid=4294967295 uid=8192 gid=0 ses=4294967295 pid=1062 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 33.102464] futex_wake_op: trinity-c5 tries to shift op by -1; fix this program [ 33.269819] warning: process `trinity-c3' used the obsolete bdflush system call [ 33.273422] Fix your initscripts? [ 34.479158] audit: type=1326 audit(1600875842.763:6): auid=4294967295 uid=4294967286 gid=0 ses=4294967295 pid=1123 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 43.430304] warning: process `trinity-c5' used the obsolete bdflush system call [ 43.432192] Fix your initscripts? [ 43.507258] futex_wake_op: trinity-c5 tries to shift op by -1; fix this program [ 44.363477] audit: type=1326 audit(196.550:7): auid=4294967295 uid=1342177344 gid=0 ses=4294967295 pid=1292 comm="trinity-c7" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 45.612803] futex_wake_op: trinity-c3 tries to shift op by -1; fix this program [ 51.074264] audit: type=1326 audit(203.261:8): auid=4294967295 uid=81 gid=0 ses=4294967295 pid=1407 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 57.741177] futex_wake_op: trinity-c7 tries to shift op by -498; fix this program [ 60.841896] audit: type=1326 audit(213.028:9): auid=4294967295 uid=0 gid=1 ses=4294967295 pid=1540 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 71.405358] audit: type=1326 audit(27734.278:10): auid=4294967295 uid=4294967291 gid=0 ses=4294967295 pid=1677 comm="trinity-c7" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 72.421709] warning: process `trinity-c7' used the obsolete bdflush system call [ 72.425275] Fix your initscripts? [ 74.338204] audit: type=1326 audit(27737.211:11): auid=4294967295 uid=117 gid=172 ses=4294967295 pid=1687 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 76.703292] ptrace attach of "init "[1] was attempted by "trinity -q -q -l off -s 594090 -x get_robust_list -x remap_file_pages -N 999999999 -X"[1834] [ 76.714121] ptrace attach of "init "[1] was attempted by "trinity -q -q -l off -s 594090 -x get_robust_list -x remap_file_pages -N 999999999 -X"[1834] [ 76.901292] futex_wake_op: trinity-c3 tries to shift op by -257; fix this program [ 77.775719] futex_wake_op: trinity-c7 tries to shift op by -1029; fix this program [ 82.902717] audit: type=1326 audit(27745.775:12): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=1955 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 88.986332] audit: type=1326 audit(27751.860:13): auid=4294967295 uid=77 gid=0 ses=4294967295 pid=1864 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 96.158490] audit: type=1326 audit(27759.032:14): auid=4294967295 uid=4467855 gid=4294967049 ses=4294967295 pid=2132 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 103.481219] ptrace attach of "init "[1] was attempted by "trinity -q -q -l off -s 594090 -x get_robust_list -x remap_file_pages -N 999999999 -X"[2174] [ 103.510297] audit: type=1326 audit(27766.384:15): auid=4294967295 uid=214 gid=0 ses=4294967295 pid=2232 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 105.567694] audit: type=1326 audit(27768.441:16): auid=4294967295 uid=1879048191 gid=0 ses=4294967295 pid=2235 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 109.840634] audit: type=1326 audit(27772.714:17): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=2356 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 109.862916] audit: type=1326 audit(27772.736:18): auid=4294967295 uid=4294967288 gid=0 ses=4294967295 pid=2357 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 119.282539] audit: type=1326 audit(27782.156:19): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=2469 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 132.565950] audit: type=1326 audit(48329.267:20): auid=4294967295 uid=0 gid=255 ses=4294967295 pid=2621 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 139.892378] audit: type=1326 audit(48336.596:21): auid=4294967295 uid=0 gid=580911104 ses=4294967295 pid=2759 comm="trinity-c3" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 140.906185] audit: type=1326 audit(48337.610:22): auid=4294967295 uid=12661381 gid=603979901 ses=4294967295 pid=2735 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 142.173551] audit: type=1326 audit(48338.877:23): auid=4294967295 uid=256 gid=240464198 ses=4294967295 pid=2798 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 146.232739] Unable to find swap-space signature [ 146.234601] audit: type=1326 audit(48342.938:24): auid=4294967295 uid=1124335632 gid=276832768 ses=4294967295 pid=2872 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 147.311815] audit: type=1326 audit(48344.014:25): auid=4294967295 uid=4294959104 gid=4294963200 ses=4294967295 pid=2892 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 150.468399] audit: type=1326 audit(48347.171:26): auid=4294967295 uid=0 gid=0 ses=4294967295 pid=2953 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 151.214410] audit: type=1326 audit(48347.917:27): auid=4294967295 uid=4294967286 gid=1 ses=4294967295 pid=2946 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 154.527195] audit: type=1326 audit(48351.230:28): auid=4294967295 uid=51251 gid=0 ses=4294967295 pid=2961 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 156.133711] scsi_nl_rcv_msg: discarding partial skb [ 157.184036] audit: type=1326 audit(48353.887:29): auid=4294967295 uid=2147479552 gid=0 ses=4294967295 pid=2994 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 159.737804] audit: type=1326 audit(48356.440:30): auid=4294967295 uid=0 gid=20480 ses=4294967295 pid=3125 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 161.831443] ptrace attach of "init "[1] was attempted by "trinity -q -q -l off -s 594090 -x get_robust_list -x remap_file_pages -N 999999999 -X"[3151] [ 166.640253] audit: type=1326 audit(48363.344:31): auid=4294967295 uid=17219 gid=4294967288 ses=4294967295 pid=3221 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 169.280911] audit: type=1326 audit(48365.984:32): auid=4294967295 uid=7339994 gid=0 ses=4294967295 pid=3319 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 173.025019] audit: type=1326 audit(48369.728:33): auid=4294967295 uid=0 gid=169 ses=4294967295 pid=3355 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 181.861647] audit: type=1326 audit(48378.564:34): auid=4294967295 uid=190 gid=0 ses=4294967295 pid=3494 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 184.454776] audit: type=1326 audit(48381.158:35): auid=4294967295 uid=607907840 gid=0 ses=4294967295 pid=3481 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 189.647646] audit: type=1326 audit(48386.351:36): auid=4294967295 uid=16384 gid=0 ses=4294967295 pid=3542 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 194.994747] audit: type=1326 audit(48391.698:37): auid=4294967295 uid=30836 gid=4294967244 ses=4294967295 pid=3636 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 196.425082] audit: type=1326 audit(48393.129:38): auid=4294967295 uid=131072 gid=0 ses=4294967295 pid=3661 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 196.535371] futex_wake_op: trinity-c1 tries to shift op by -1; fix this program [ 200.004155] audit: type=1326 audit(200.582:39): auid=4294967295 uid=8192 gid=4294967289 ses=4294967295 pid=3799 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 202.052561] futex_wake_op: trinity-c0 tries to shift op by -1; fix this program [ 205.482427] Unable to find swap-space signature [ 209.064974] audit: type=1326 audit(209.643:40): auid=4294967295 uid=104 gid=0 ses=4294967295 pid=3966 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 214.450499] futex_wake_op: trinity-c2 tries to shift op by -1; fix this program [ 215.315941] audit: type=1326 audit(65536.108:41): auid=4294967295 uid=4294967293 gid=4282827626 ses=4294967295 pid=4068 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 217.625155] audit: type=1326 audit(65538.418:42): auid=4294967295 uid=8 gid=0 ses=4294967295 pid=4095 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 219.239345] futex_wake_op: trinity-c1 tries to shift op by -354; fix this program [ 236.830738] audit: type=1326 audit(65557.603:43): auid=4294967295 uid=3046 gid=268435456 ses=4294967295 pid=4362 comm="trinity-c7" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 244.126827] audit: type=1326 audit(65564.903:44): auid=4294967295 uid=1073741898 gid=0 ses=4294967295 pid=4537 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 247.171386] audit: type=1326 audit(65567.949:45): auid=4294967295 uid=0 gid=4294967290 ses=4294967295 pid=4429 comm="trinity-c7" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 249.921684] audit: type=1326 audit(65570.701:46): auid=4294967295 uid=0 gid=4294967293 ses=4294967295 pid=4620 comm="trinity-c0" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 254.574467] audit: type=1326 audit(65575.356:47): auid=4294967295 uid=972025287 gid=0 ses=4294967295 pid=4682 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 262.754944] audit: type=1326 audit(65583.540:48): auid=4294967295 uid=268435456 gid=4261404672 ses=4294967295 pid=4669 comm="trinity-c7" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 267.941484] ptrace attach of "init "[1] was attempted by "trinity -q -q -l off -s 594090 -x get_robust_list -x remap_file_pages -N 999999999 -X"[4844] [ 269.982393] audit: type=1326 audit(65590.771:49): auid=4294967295 uid=61440 gid=0 ses=4294967295 pid=4881 comm="trinity-c6" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 275.239202] futex_wake_op: trinity-c4 tries to shift op by 1328; fix this program [ 280.561823] audit: type=1326 audit(65601.356:50): auid=4294967295 uid=16326712 gid=0 ses=4294967295 pid=5014 comm="trinity-c1" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 285.595231] audit: type=1326 audit(65606.351:51): auid=4294967295 uid=4294967286 gid=262144 ses=4294967295 pid=5084 comm="trinity-c5" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 286.648363] futex_wake_op: trinity-c5 tries to shift op by -1; fix this program [ 288.629269] audit: type=1326 audit(65609.385:52): auid=4294967295 uid=168 gid=4294967289 ses=4294967295 pid=5046 comm="trinity-c4" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 290.768135] audit: type=1326 audit(65611.526:53): auid=4294967295 uid=0 gid=581469218 ses=4294967295 pid=5147 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 294.911554] futex_wake_op: trinity-c5 tries to shift op by -81; fix this program [ 298.987156] futex_wake_op: trinity-c2 tries to shift op by -1157; fix this program [ 301.205739] trinity-c7 invoked oom-killer: gfp_mask=0x100cca(GFP_HIGHUSER_MOVABLE), order=0, oom_score_adj=500 [ 301.208458] CPU: 1 PID: 5184 Comm: trinity-c7 Not tainted 5.9.0-rc1-00605-g05b35e7eb9a1 #19 [ 301.210476] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1 04/01/2014 [ 301.212578] Call Trace: [ 301.213319] dump_stack+0x96/0xdb [ 301.214204] dump_header+0x4f/0x3f0 [ 301.215127] oom_kill_process+0xfa/0x210 [ 301.216133] out_of_memory+0x11a/0x620 [ 301.217109] __alloc_pages_slowpath.constprop.107+0xbaa/0xf70 [ 301.218483] __alloc_pages_nodemask+0x3b4/0x450 [ 301.219610] alloc_pages_vma+0x7c/0x200 [ 301.220601] shmem_alloc_page+0x47/0x90 [ 301.221607] shmem_alloc_and_acct_page+0x78/0x1c0 [ 301.222767] shmem_getpage_gfp+0x17a/0x8d0 [ 301.223813] shmem_fallocate+0x439/0x5c0 [ 301.224821] ? lock_acquire+0xac/0x3b0 [ 301.225795] ? vfs_fallocate+0x1f4/0x270 [ 301.226803] ? __sb_start_write+0x190/0x280 [ 301.227858] ? preempt_count_sub+0xa1/0xe0 [ 301.228898] vfs_fallocate+0x142/0x270 [ 301.229876] ksys_fallocate+0x3c/0x70 [ 301.230834] __ia32_sys_ia32_fallocate+0x2e/0x40 [ 301.231971] do_int80_syscall_32+0x41/0x50 [ 301.233008] entry_INT80_compat+0x88/0x8d [ 301.234034] RIP: 0033:0x407ebc [ 301.234871] Code: 83 c0 01 41 89 80 40 30 00 00 8b 44 24 04 4c 89 d1 48 8b 54 24 08 4c 89 de 4c 89 e7 55 41 50 41 51 41 52 41 53 4c 89 cd cd 80 <41> 5b 41 5a 41 59 41 58 5d 48 3d 7a ff ff ff 49 89 c4 0f 87 5c 01 [ 301.238992] RSP: 002b:00007ffc345ba048 EFLAGS: 00000202 ORIG_RAX: 0000000000000144 [ 301.240825] RAX: ffffffffffffffda RBX: 0000000000000129 RCX: 0000000000000000 [ 301.242446] RDX: 00000000000000de RSI: 0000000000000004 RDI: 0000000000000100 [ 301.244063] RBP: 0000000002000000 R08: 00007f69e6087000 R09: 0000000002000000 [ 301.245684] R10: 0000000000000000 R11: 0000000000000004 R12: 0000000000000100 [ 301.247302] R13: 00007f69e5d5f058 R14: 0000000002cc3850 R15: 00007f69e5d5f000 [ 301.249120] Mem-Info: [ 301.249896] active_anon:6522 inactive_anon:1701031 isolated_anon:0 [ 301.249896] active_file:0 inactive_file:10 isolated_file:0 [ 301.249896] unevictable:12230 dirty:2 writeback:0 [ 301.249896] slab_reclaimable:12215 slab_unreclaimable:11838 [ 301.249896] mapped:11302 shmem:1703813 pagetables:445 bounce:0 [ 301.249896] free:25493 free_pcp:267 free_cma:0 [ 301.260298] Node 0 active_anon:26088kB inactive_anon:6804124kB active_file:0kB inactive_file:40kB unevictable:48920kB isolated(anon):0kB isolated(file):0kB mapped:45208kB dirty:8kB writeback:0kB shmem:6815252kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB kernel_stack:1680kB all_unreclaimable? yes [ 301.266590] Node 0 DMA free:14884kB min:148kB low:184kB high:220kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.272412] lowmem_reserve[]: 0 2985 6917 6917 6917 [ 301.273658] Node 0 DMA32 free:44348kB min:29104kB low:36380kB high:43656kB reserved_highatomic:0KB active_anon:8kB inactive_anon:3010296kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129160kB managed:3063624kB mlocked:0kB pagetables:136kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.280111] lowmem_reserve[]: 0 0 3931 3931 3931 [ 301.281301] Node 0 Normal free:42740kB min:38328kB low:47908kB high:57488kB reserved_highatomic:0KB active_anon:26080kB inactive_anon:3793128kB active_file:0kB inactive_file:40kB unevictable:48920kB writepending:8kB present:4213760kB managed:4034136kB mlocked:1032kB pagetables:1644kB bounce:0kB free_pcp:528kB local_pcp:32kB free_cma:0kB [ 301.287856] lowmem_reserve[]: 0 0 0 0 0 [ 301.288985] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 0*1024kB 1*2048kB (M) 3*4096kB (M) = 14884kB [ 301.291957] Node 0 DMA32: 32*4kB (U) 15*8kB (UME) 13*16kB (UE) 7*32kB (U) 5*64kB (UME) 2*128kB (U) 2*256kB (ME) 2*512kB (UM) 3*1024kB (UME) 1*2048kB (M) 9*4096kB (M) = 44776kB [ 301.295522] Node 0 Normal: 390*4kB (UME) 321*8kB (UME) 585*16kB (UME) 321*32kB (UME) 151*64kB (UME) 45*128kB (UME) 6*256kB (UE) 3*512kB (UM) 0*1024kB 0*2048kB 0*4096kB = 42256kB [ 301.299134] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 301.301373] 1715808 total pagecache pages [ 301.302577] 0 pages in swap cache [ 301.303747] Swap cache stats: add 0, delete 0, find 0/0 [ 301.305134] Free swap = 0kB [ 301.306004] Total swap = 0kB [ 301.306837] 1839728 pages RAM [ 301.307666] 0 pages HighMem/MovableOnly [ 301.308685] 61311 pages reserved [ 301.309597] 0 pages cma reserved [ 301.310512] 0 pages hwpoisoned [ 301.311381] Tasks state (memory values in pages): [ 301.314183] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 301.316386] [ 136] 0 136 922 547 49152 0 -1000 udevd [ 301.323069] [ 303] 0 303 1034 281 40960 0 0 syslogd [ 301.325312] [ 306] 0 306 1034 297 45056 0 0 klogd [ 301.327310] [ 312] 0 312 1034 35 49152 0 0 S77lkp-bootstra [ 301.329455] [ 314] 0 314 1066 592 45056 0 -1000 lkp-setup-rootf [ 301.331614] [ 325] 0 325 1034 538 49152 0 0 start_getty [ 301.333778] [ 327] 0 327 1034 283 40960 0 0 getty [ 301.335853] [ 339] 0 339 1034 285 49152 0 -1000 tail [ 301.337821] [ 378] 0 378 1034 283 40960 0 0 getty [ 301.339883] [ 431] 0 431 1069 606 40960 0 -1000 run-lkp [ 301.341904] [ 448] 0 448 1035 297 53248 0 -1000 tail [ 301.343878] [ 449] 0 449 1035 284 49152 0 -1000 tail [ 301.345841] [ 450] 0 450 1035 284 40960 0 -1000 tail [ 301.347855] [ 512] 0 512 1035 565 49152 0 1000 trinity-300s-yo [ 301.350008] [ 521] 0 521 1002 285 40960 0 0 cat [ 301.351962] [ 526] 0 526 617 220 45056 0 0 vmstat [ 301.353957] [ 528] 0 528 1035 577 40960 0 0 meminfo [ 301.355977] [ 534] 0 534 1035 584 45056 0 -1000 oom-killer [ 301.358255] [ 545] 0 545 1035 283 45056 0 0 watchdog [ 301.360309] [ 554] 0 554 270 2 32768 0 0 wait [ 301.362293] [ 564] 0 564 270 14 32768 0 0 wakeup [ 301.364302] [ 575] 0 575 270 14 32768 0 0 wakeup [ 301.366299] [ 586] 0 586 1002 301 49152 0 0 cat [ 301.368251] [ 588] 0 588 1002 284 45056 0 0 cat [ 301.370194] [ 592] 0 592 1068 523 45056 0 0 gzip [ 301.372163] [ 596] 0 596 1002 300 40960 0 0 cat [ 301.374108] [ 645] 0 645 1035 610 45056 0 0 trinity [ 301.376130] [ 648] 0 648 1035 301 49152 0 0 tee [ 301.378080] [ 657] 0 657 1035 35 45056 0 0 trinity [ 301.380106] [ 658] 0 658 1002 284 40960 0 0 sleep [ 301.382100] [ 660] 0 660 13180 9311 163840 0 0 trinity-main [ 301.384206] [ 5039] 32 5039 13011 8666 159744 0 500 trinity-c1 [ 301.386269] [ 5141] 86 5141 13737 9653 155648 0 500 trinity-c4 [ 301.388339] [ 5149] 0 5149 13738 8937 159744 0 500 trinity-c2 [ 301.390398] [ 5159] 512 5159 13199 7118 155648 0 500 trinity-c0 [ 301.392464] [ 5184] -2 5184 13246 8649 151552 0 500 trinity-c7 [ 301.394602] [ 5206] 0 5206 270 2 32768 0 -1000 wait [ 301.396573] [ 5238] 200 5238 13663 7369 159744 0 500 trinity-c5 [ 301.398638] [ 5255] 216160412 5255 13184 5607 151552 0 500 trinity-c6 [ 301.400823] [ 5269] 0 5269 270 2 32768 0 0 wait [ 301.404378] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=trinity-300s-yo,pid=512,uid=0 [ 301.407440] Out of memory: Killed process 512 (trinity-300s-yo) total-vm:4140kB, anon-rss:196kB, file-rss:2064kB, shmem-rss:0kB, UID:0 pgtables:48kB oom_score_adj:1000 [ 301.428857] trinity-c7 invoked oom-killer: gfp_mask=0x100cca(GFP_HIGHUSER_MOVABLE), order=0, oom_score_adj=500 [ 301.431355] CPU: 1 PID: 5184 Comm: trinity-c7 Not tainted 5.9.0-rc1-00605-g05b35e7eb9a1 #19 [ 301.433367] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1 04/01/2014 [ 301.435467] Call Trace: [ 301.436203] dump_stack+0x96/0xdb [ 301.437077] dump_header+0x4f/0x3f0 [ 301.438017] oom_kill_process+0xfa/0x210 [ 301.438988] out_of_memory+0x11a/0x620 [ 301.440058] __alloc_pages_slowpath.constprop.107+0xbaa/0xf70 [ 301.441427] __alloc_pages_nodemask+0x3b4/0x450 [ 301.442544] alloc_pages_vma+0x7c/0x200 [ 301.443529] shmem_alloc_page+0x47/0x90 [ 301.444517] shmem_alloc_and_acct_page+0x78/0x1c0 [ 301.445674] shmem_getpage_gfp+0x17a/0x8d0 [ 301.446718] shmem_fallocate+0x439/0x5c0 [ 301.447727] ? lock_acquire+0xac/0x3b0 [ 301.448731] ? vfs_fallocate+0x1f4/0x270 [ 301.449759] ? __sb_start_write+0x190/0x280 [ 301.450809] ? preempt_count_sub+0xa1/0xe0 [ 301.451840] vfs_fallocate+0x142/0x270 [ 301.452849] ksys_fallocate+0x3c/0x70 [ 301.454056] __ia32_sys_ia32_fallocate+0x2e/0x40 [ 301.455178] do_int80_syscall_32+0x41/0x50 [ 301.456215] entry_INT80_compat+0x88/0x8d [ 301.457233] RIP: 0033:0x407ebc [ 301.458059] Code: 83 c0 01 41 89 80 40 30 00 00 8b 44 24 04 4c 89 d1 48 8b 54 24 08 4c 89 de 4c 89 e7 55 41 50 41 51 41 52 41 53 4c 89 cd cd 80 <41> 5b 41 5a 41 59 41 58 5d 48 3d 7a ff ff ff 49 89 c4 0f 87 5c 01 [ 301.462148] RSP: 002b:00007ffc345ba048 EFLAGS: 00000202 ORIG_RAX: 0000000000000144 [ 301.464027] RAX: ffffffffffffffda RBX: 0000000000000129 RCX: 0000000000000000 [ 301.465641] RDX: 00000000000000de RSI: 0000000000000004 RDI: 0000000000000100 [ 301.467284] RBP: 0000000002000000 R08: 00007f69e6087000 R09: 0000000002000000 [ 301.468895] R10: 0000000000000000 R11: 0000000000000004 R12: 0000000000000100 [ 301.470505] R13: 00007f69e5d5f058 R14: 0000000002cc3850 R15: 00007f69e5d5f000 [ 301.479409] scsi_nl_rcv_msg: discarding partial skb [ 301.486804] Mem-Info: [ 301.487593] active_anon:6525 inactive_anon:1701652 isolated_anon:0 [ 301.487593] active_file:0 inactive_file:13 isolated_file:0 [ 301.487593] unevictable:12243 dirty:6 writeback:0 [ 301.487593] slab_reclaimable:12193 slab_unreclaimable:11835 [ 301.487593] mapped:11305 shmem:1704413 pagetables:410 bounce:0 [ 301.487593] free:24558 free_pcp:376 free_cma:0 [ 301.494793] Node 0 active_anon:26100kB inactive_anon:6806608kB active_file:0kB inactive_file:52kB unevictable:48972kB isolated(anon):0kB isolated(file):0kB mapped:45220kB dirty:24kB writeback:0kB shmem:6817652kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB kernel_stack:1648kB all_unreclaimable? yes [ 301.501070] Node 0 DMA free:14884kB min:148kB low:184kB high:220kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.506878] lowmem_reserve[]: 0 2985 6917 6917 6917 [ 301.508103] Node 0 DMA32 free:44540kB min:29104kB low:36380kB high:43656kB reserved_highatomic:0KB active_anon:8kB inactive_anon:3010296kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129160kB managed:3063624kB mlocked:0kB pagetables:136kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.514502] lowmem_reserve[]: 0 0 3931 3931 3931 [ 301.515684] Node 0 Normal free:38808kB min:38328kB low:47908kB high:57488kB reserved_highatomic:0KB active_anon:26092kB inactive_anon:3795784kB active_file:0kB inactive_file:52kB unevictable:48972kB writepending:20kB present:4213760kB managed:4034136kB mlocked:1032kB pagetables:1504kB bounce:0kB free_pcp:1312kB local_pcp:0kB free_cma:0kB [ 301.522242] lowmem_reserve[]: 0 0 0 0 0 [ 301.523297] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 0*1024kB 1*2048kB (M) 3*4096kB (M) = 14884kB [ 301.527448] Node 0 DMA32: 29*4kB (U) 16*8kB (UME) 12*16kB (UE) 6*32kB (U) 6*64kB (UME) 2*128kB (U) 2*256kB (ME) 2*512kB (UM) 3*1024kB (UME) 1*2048kB (M) 9*4096kB (M) = 44788kB [ 301.531052] Node 0 Normal: 365*4kB (UME) 314*8kB (UE) 559*16kB (UME) 308*32kB (UME) 141*64kB (UME) 43*128kB (UME) 6*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 38836kB [ 301.534821] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 301.537195] 1716410 total pagecache pages [ 301.538728] 0 pages in swap cache [ 301.539627] Swap cache stats: add 0, delete 0, find 0/0 [ 301.540960] Free swap = 0kB [ 301.542015] Total swap = 0kB [ 301.543623] 1839728 pages RAM [ 301.544534] 0 pages HighMem/MovableOnly [ 301.545646] 61311 pages reserved [ 301.546596] 0 pages cma reserved [ 301.547843] 0 pages hwpoisoned [ 301.548762] Tasks state (memory values in pages): [ 301.550005] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 301.553078] [ 136] 0 136 922 547 49152 0 -1000 udevd [ 301.555347] [ 303] 0 303 1034 281 40960 0 0 syslogd [ 301.558993] [ 306] 0 306 1034 297 45056 0 0 klogd [ 301.561001] [ 312] 0 312 1034 35 49152 0 0 S77lkp-bootstra [ 301.563171] [ 314] 0 314 1066 592 45056 0 -1000 lkp-setup-rootf [ 301.566857] [ 325] 0 325 1034 538 49152 0 0 start_getty [ 301.568933] [ 327] 0 327 1034 283 40960 0 0 getty [ 301.570923] [ 339] 0 339 1034 285 49152 0 -1000 tail [ 301.572877] [ 378] 0 378 1034 283 40960 0 0 getty [ 301.574863] [ 431] 0 431 1069 608 40960 0 -1000 run-lkp [ 301.576881] [ 521] 0 521 1002 285 40960 0 0 cat [ 301.578837] [ 526] 0 526 617 220 45056 0 0 vmstat [ 301.580820] [ 545] 0 545 1035 283 45056 0 0 watchdog [ 301.582870] [ 554] 0 554 270 2 32768 0 0 wait [ 301.584819] [ 564] 0 564 270 14 32768 0 0 wakeup [ 301.586819] [ 575] 0 575 270 14 32768 0 0 wakeup [ 301.588804] [ 586] 0 586 1002 301 49152 0 0 cat [ 301.590758] [ 588] 0 588 1002 284 45056 0 0 cat [ 301.592694] [ 645] 0 645 1035 610 45056 0 0 trinity [ 301.594708] [ 648] 0 648 1035 301 49152 0 0 tee [ 301.596644] [ 657] 0 657 1035 35 45056 0 0 trinity [ 301.598675] [ 658] 0 658 1002 284 40960 0 0 sleep [ 301.600635] [ 660] 0 660 13180 9311 163840 0 0 trinity-main [ 301.602780] [ 5039] 32 5039 13011 8666 159744 0 500 trinity-c1 [ 301.604823] [ 5141] 86 5141 13737 9653 155648 0 500 trinity-c4 [ 301.606887] [ 5149] 0 5149 13738 8937 159744 0 500 trinity-c2 [ 301.608932] [ 5159] 512 5159 13199 7118 155648 0 500 trinity-c0 [ 301.610993] [ 5184] -2 5184 13246 8649 151552 0 500 trinity-c7 [ 301.613291] [ 5238] 200 5238 13663 7369 159744 0 500 trinity-c5 [ 301.615381] [ 5255] 216160412 5255 13184 6280 151552 0 500 trinity-c6 [ 301.617513] [ 5288] 0 5288 1035 552 45056 0 -1000 post-run [ 301.619545] [ 5290] 0 5290 270 15 32768 0 -1000 wakeup [ 301.621547] [ 5292] 0 5292 270 15 32768 0 -1000 wakeup [ 301.623541] [ 5294] 0 5294 1002 298 45056 0 -1000 sleep [ 301.625530] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=trinity-c4,pid=5141,uid=86 [ 301.628428] Out of memory: Killed process 5141 (trinity-c4) total-vm:54948kB, anon-rss:5656kB, file-rss:10700kB, shmem-rss:22256kB, UID:86 pgtables:152kB oom_score_adj:500 [ 301.639502] trinity-main invoked oom-killer: gfp_mask=0x400dc0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), order=1, oom_score_adj=0 [ 301.642596] CPU: 0 PID: 660 Comm: trinity-main Not tainted 5.9.0-rc1-00605-g05b35e7eb9a1 #19 [ 301.644600] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1 04/01/2014 [ 301.646713] Call Trace: [ 301.647441] dump_stack+0x96/0xdb [ 301.648341] dump_header+0x4f/0x3f0 [ 301.649309] oom_kill_process+0xfa/0x210 [ 301.651905] out_of_memory+0x11a/0x620 [ 301.652982] __alloc_pages_slowpath.constprop.107+0xbaa/0xf70 [ 301.654361] __alloc_pages_nodemask+0x3b4/0x450 [ 301.655476] __get_free_pages+0xd/0x40 [ 301.656437] pgd_alloc+0x33/0x220 [ 301.657324] mm_init+0x1cd/0x2a0 [ 301.658185] dup_mm+0x66/0x580 [ 301.659019] ? lockdep_init_map_waits+0x57/0x230 [ 301.660217] copy_process+0x1cb0/0x1d50 [ 301.661229] _do_fork+0x9d/0x700 [ 301.662096] ? __might_fault+0x3e/0x90 [ 301.663064] ? find_held_lock+0x2d/0x90 [ 301.664044] ? __might_fault+0x3e/0x90 [ 301.665011] __do_sys_clone+0x72/0x90 [ 301.665968] do_syscall_64+0x33/0x40 [ 301.666900] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 301.668111] RIP: 0033:0x45ee0b [ 301.668941] Code: db 45 85 f6 0f 85 95 01 00 00 64 4c 8b 04 25 10 00 00 00 31 d2 4d 8d 90 d0 02 00 00 31 f6 bf 11 00 20 01 b8 38 00 00 00 0f 05 <48> 3d 00 f0 ff ff 0f 87 d6 00 00 00 85 c0 41 89 c5 0f 85 dd 00 00 [ 301.673024] RSP: 002b:00007ffc345ba230 EFLAGS: 00000246 ORIG_RAX: 0000000000000038 [ 301.674847] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000000000045ee0b [ 301.676448] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 301.678057] RBP: 00007ffc345ba260 R08: 0000000002cc3880 R09: 0000000002cc3880 [ 301.679659] R10: 0000000002cc3b50 R11: 0000000000000246 R12: 0000000000000000 [ 301.681282] R13: 0000000000000004 R14: 0000000000000000 R15: 0000000000000008 [ 301.707409] Mem-Info: [ 301.736869] active_anon:7250 inactive_anon:1701577 isolated_anon:0 [ 301.736869] active_file:0 inactive_file:13 isolated_file:0 [ 301.736869] unevictable:12243 dirty:6 writeback:0 [ 301.736869] slab_reclaimable:12142 slab_unreclaimable:11810 [ 301.736869] mapped:11180 shmem:1705888 pagetables:373 bounce:0 [ 301.736869] free:24376 free_pcp:42 free_cma:0 [ 301.787873] Killed [ 301.791823] Node 0 active_anon:29000kB inactive_anon:6806308kB active_file:0kB inactive_file:52kB unevictable:48972kB isolated(anon):0kB isolated(file):0kB mapped:44720kB dirty:24kB writeback:0kB shmem:6823552kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB kernel_stack:1552kB all_unreclaimable? yes [ 301.804585] Node 0 DMA free:14884kB min:148kB low:184kB high:220kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.830432] lowmem_reserve[]: 0 2985 6917 6917 6917 [ 301.841517] Node 0 DMA32 free:44648kB min:29104kB low:36380kB high:43656kB reserved_highatomic:0KB active_anon:8kB inactive_anon:3010296kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129160kB managed:3063624kB mlocked:0kB pagetables:136kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 301.879171] lowmem_reserve[]: 0 0 3931 3931 3931 [ 301.880370] Node 0 Normal free:38016kB min:38328kB low:47908kB high:57488kB reserved_highatomic:0KB active_anon:28960kB inactive_anon:3795852kB active_file:0kB inactive_file:64kB unevictable:48972kB writepending:28kB present:4213760kB managed:4034136kB mlocked:1032kB pagetables:1288kB bounce:0kB free_pcp:168kB local_pcp:8kB free_cma:0kB [ 301.890660] lowmem_reserve[]: 0 0 0 0 0 [ 301.891749] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 0*1024kB 1*2048kB (M) 3*4096kB (M) = 14884kB [ 301.898523] Node 0 DMA32: 24*4kB (UM) 16*8kB (UME) 12*16kB (UME) 10*32kB (UM) 6*64kB (UME) 2*128kB (U) 2*256kB (ME) 2*512kB (UM) 3*1024kB (UME) 1*2048kB (M) 9*4096kB (M) = 44896kB [ 301.906460] Node 0 Normal: 486*4kB (UME) 324*8kB (UME) 554*16kB (UME) 296*32kB (UE) 133*64kB (UME) 44*128kB (UME) 5*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 38296kB [ 301.913892] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 301.919878] 1717861 total pagecache pages [ 301.920960] 0 pages in swap cache [ 301.925681] Swap cache stats: add 0, delete 0, find 0/0 [ 301.927042] Free swap = 0kB [ 301.931704] Total swap = 0kB [ 301.932523] 1839728 pages RAM [ 301.933345] 0 pages HighMem/MovableOnly [ 301.938160] 61311 pages reserved [ 301.939101] 0 pages cma reserved [ 301.943825] 0 pages hwpoisoned [ 301.944806] Tasks state (memory values in pages): [ 301.949864] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 301.955742] [ 136] 0 136 922 547 49152 0 -1000 udevd [ 301.961644] [ 303] 0 303 1034 281 40960 0 0 syslogd [ 301.967501] [ 306] 0 306 1034 297 45056 0 0 klogd [ 301.973434] [ 312] 0 312 1034 35 49152 0 0 S77lkp-bootstra [ 301.984667] [ 314] 0 314 1066 592 45056 0 -1000 lkp-setup-rootf [ 301.999003] [ 325] 0 325 1034 538 49152 0 0 start_getty [ 302.001156] [ 327] 0 327 1034 283 40960 0 0 getty [ 302.004117] [ 339] 0 339 1034 285 49152 0 -1000 tail [ 302.021825] [ 378] 0 378 1034 283 40960 0 0 getty [ 302.036322] [ 431] 0 431 1069 608 40960 0 -1000 run-lkp [ 302.051932] [ 521] 0 521 1002 285 40960 0 0 cat [ 302.060334] [ 526] 0 526 617 220 45056 0 0 vmstat [ 302.076716] [ 545] 0 545 1035 283 45056 0 0 watchdog [ 302.090779] [ 554] 0 554 270 2 32768 0 0 wait [ 302.096943] [ 564] 0 564 270 14 32768 0 0 wakeup [ 302.099567] [ 575] 0 575 270 14 32768 0 0 wakeup [ 302.102325] [ 586] 0 586 1002 301 49152 0 0 cat [ 302.105028] [ 588] 0 588 1002 284 45056 0 0 cat [ 302.107717] [ 645] 0 645 1035 610 45056 0 0 trinity [ 302.110509] [ 648] 0 648 1035 301 49152 0 0 tee [ 302.113212] [ 657] 0 657 1035 35 45056 0 0 trinity [ 302.115981] [ 658] 0 658 1002 284 40960 0 0 sleep [ 302.118698] [ 660] 0 660 13180 9311 163840 0 0 trinity-main [ 302.121578] [ 5039] 32 5039 13011 8666 159744 0 500 trinity-c1 [ 302.124383] [ 5149] 0 5149 13738 8937 159744 0 500 trinity-c2 [ 302.127193] [ 5159] 512 5159 13199 7118 155648 0 500 trinity-c0 [ 302.130043] [ 5184] -2 5184 13246 8649 151552 0 500 trinity-c7 [ 302.132863] [ 5238] 200 5238 13663 7369 159744 0 500 trinity-c5 [ 302.135661] [ 5255] 216160412 5255 13184 6280 151552 0 500 trinity-c6 [ 302.138571] [ 5288] 0 5288 1035 552 45056 0 -1000 post-run [ 302.141380] [ 5290] 0 5290 270 15 32768 0 -1000 wakeup [ 302.144134] [ 5292] 0 5292 270 15 32768 0 -1000 wakeup [ 302.146892] [ 5294] 0 5294 1002 298 45056 0 -1000 sleep [ 302.149637] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=trinity-c2,pid=5149,uid=0 [ 302.153369] Out of memory: Killed process 5149 (trinity-c2) total-vm:54952kB, anon-rss:5576kB, file-rss:10700kB, shmem-rss:19472kB, UID:0 pgtables:156kB oom_score_adj:500 [ 302.162224] trinity-main invoked oom-killer: gfp_mask=0x400dc0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), order=1, oom_score_adj=0 [ 302.165691] CPU: 1 PID: 660 Comm: trinity-main Not tainted 5.9.0-rc1-00605-g05b35e7eb9a1 #19 [ 302.167691] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1 04/01/2014 [ 302.169783] Call Trace: [ 302.170501] dump_stack+0x96/0xdb [ 302.171383] dump_header+0x4f/0x3f0 [ 302.172297] oom_kill_process+0xfa/0x210 [ 302.173312] out_of_memory+0x11a/0x620 [ 302.174278] __alloc_pages_slowpath.constprop.107+0xbaa/0xf70 [ 302.175633] __alloc_pages_nodemask+0x3b4/0x450 [ 302.176749] __get_free_pages+0xd/0x40 [ 302.177717] pgd_alloc+0x33/0x220 [ 302.178629] mm_init+0x1cd/0x2a0 [ 302.179487] dup_mm+0x66/0x580 [ 302.180318] ? lockdep_init_map_waits+0x57/0x230 [ 302.181469] copy_process+0x1cb0/0x1d50 [ 302.182454] _do_fork+0x9d/0x700 [ 302.183318] ? __might_fault+0x3e/0x90 [ 302.184280] ? find_held_lock+0x2d/0x90 [ 302.185262] ? __might_fault+0x3e/0x90 [ 302.186227] __do_sys_clone+0x72/0x90 [ 302.187179] do_syscall_64+0x33/0x40 [ 302.188141] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 302.189364] RIP: 0033:0x45ee0b [ 302.190193] Code: db 45 85 f6 0f 85 95 01 00 00 64 4c 8b 04 25 10 00 00 00 31 d2 4d 8d 90 d0 02 00 00 31 f6 bf 11 00 20 01 b8 38 00 00 00 0f 05 <48> 3d 00 f0 ff ff 0f 87 d6 00 00 00 85 c0 41 89 c5 0f 85 dd 00 00 [ 302.195843] RSP: 002b:00007ffc345ba230 EFLAGS: 00000246 ORIG_RAX: 0000000000000038 [ 302.197684] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000000000045ee0b [ 302.199287] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 302.200893] RBP: 00007ffc345ba260 R08: 0000000002cc3880 R09: 0000000002cc3880 [ 302.202503] R10: 0000000002cc3b50 R11: 0000000000000246 R12: 0000000000000000 [ 302.204108] R13: 0000000000000004 R14: 0000000000000000 R15: 0000000000000008 [ 302.226979] Mem-Info: [ 302.227743] active_anon:7285 inactive_anon:1701414 isolated_anon:0 [ 302.227743] active_file:0 inactive_file:0 isolated_file:0 [ 302.227743] unevictable:12243 dirty:0 writeback:0 [ 302.227743] slab_reclaimable:12117 slab_unreclaimable:11767 [ 302.227743] mapped:11156 shmem:1706316 pagetables:327 bounce:0 [ 302.227743] free:24456 free_pcp:300 free_cma:0 [ 302.260607] Node 0 active_anon:29140kB inactive_anon:6805656kB active_file:0kB inactive_file:0kB unevictable:48972kB isolated(anon):0kB isolated(file):0kB mapped:44624kB dirty:0kB writeback:0kB shmem:6825264kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB kernel_stack:1568kB all_unreclaimable? yes [ 302.290005] Node 0 DMA free:14884kB min:148kB low:184kB high:220kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 302.332961] lowmem_reserve[]: 0 2985 6917 6917 6917 [ 302.334242] Node 0 DMA32 free:44644kB min:29104kB low:36380kB high:43656kB reserved_highatomic:0KB active_anon:0kB inactive_anon:3010492kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129160kB managed:3063624kB mlocked:0kB pagetables:120kB bounce:0kB free_pcp:340kB local_pcp:92kB free_cma:0kB [ 302.366325] lowmem_reserve[]: 0 0 3931 3931 3931 [ 302.367622] Node 0 Normal free:38296kB min:38328kB low:47908kB high:57488kB reserved_highatomic:0KB active_anon:29140kB inactive_anon:3795264kB active_file:0kB inactive_file:0kB unevictable:48972kB writepending:0kB present:4213760kB managed:4034136kB mlocked:1032kB pagetables:1188kB bounce:0kB free_pcp:860kB local_pcp:516kB free_cma:0kB [ 302.382778] lowmem_reserve[]: 0 0 0 0 0 [ 302.396545] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 0*1024kB 1*2048kB (M) 3*4096kB (M) = 14884kB [ 302.402687] Node 0 DMA32: 21*4kB (U) 14*8kB (UE) 12*16kB (UME) 9*32kB (U) 5*64kB (UE) 3*128kB (UM) 1*256kB (E) 2*512kB (UM) 3*1024kB (UME) 1*2048kB (M) 9*4096kB (M) = 44644kB [ 302.418950] Node 0 Normal: 504*4kB (UME) 325*8kB (UE) 552*16kB (UME) 295*32kB (UME) 134*64kB (UE) 42*128kB (UME) 6*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 38376kB [ 302.425428] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 302.440260] 1718301 total pagecache pages [ 302.441355] 0 pages in swap cache [ 302.445354] Swap cache stats: add 0, delete 0, find 0/0 [ 302.459359] Free swap = 0kB [ 302.460252] Total swap = 0kB [ 302.461051] 1839728 pages RAM [ 302.464965] 0 pages HighMem/MovableOnly [ 302.465969] 61311 pages reserved [ 302.479636] 0 pages cma reserved [ 302.480578] 0 pages hwpoisoned [ 302.496800] Tasks state (memory values in pages): [ 302.506655] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 302.519901] [ 136] 0 136 922 547 49152 0 -1000 udevd [ 302.533155] [ 303] 0 303 1034 281 40960 0 0 syslogd [ 302.546314] [ 306] 0 306 1034 297 45056 0 0 klogd [ 302.567586] [ 312] 0 312 1034 35 49152 0 0 S77lkp-bootstra [ 302.574702] [ 314] 0 314 1066 592 45056 0 -1000 lkp-setup-rootf [ 302.588095] [ 325] 0 325 1034 538 49152 0 0 start_getty [ 302.601566] [ 327] 0 327 1034 283 40960 0 0 getty [ 302.614617] [ 339] 0 339 1034 285 49152 0 -1000 tail [ 302.627783] [ 378] 0 378 1034 283 40960 0 0 getty [ 302.641077] [ 431] 0 431 1069 608 40960 0 -1000 run-lkp [ 302.654249] [ 521] 0 521 1002 285 40960 0 0 cat [ 302.667525] [ 526] 0 526 617 220 45056 0 0 vmstat [ 302.680514] [ 545] 0 545 1035 283 45056 0 0 watchdog [ 302.693745] [ 554] 0 554 270 2 32768 0 0 wait [ 302.706886] [ 564] 0 564 270 14 32768 0 0 wakeup [ 302.720204] [ 575] 0 575 270 14 32768 0 0 wakeup [ 302.733737] [ 586] 0 586 1002 301 49152 0 0 cat [ 302.746821] [ 588] 0 588 1002 284 45056 0 0 cat [ 302.759895] [ 645] 0 645 1035 610 45056 0 0 trinity [ 302.771791] [ 648] 0 648 1035 301 49152 0 0 tee [ 302.783998] [ 657] 0 657 1035 35 45056 0 0 trinity [ 302.799731] [ 658] 0 658 1002 284 40960 0 0 sleep [ 302.833803] [ 660] 0 660 13180 9311 163840 0 0 trinity-main [ 302.862117] [ 5039] 32 5039 13011 8666 159744 0 500 trinity-c1 [ 302.889219] [ 5159] 512 5159 13199 7118 155648 0 500 trinity-c0 [ 302.915793] [ 5184] -2 5184 13246 8649 151552 0 500 trinity-c7 [ 302.942998] [ 5238] 200 5238 13663 7450 159744 0 500 trinity-c5 [ 302.969547] [ 5255] 216160412 5255 13184 6280 151552 0 500 trinity-c6 [ 303.000080] [ 5288] 0 5288 1035 552 45056 0 -1000 post-run [ 303.022851] [ 5290] 0 5290 270 15 32768 0 -1000 wakeup [ 303.050540] [ 5292] 0 5292 270 15 32768 0 -1000 wakeup [ 303.079546] [ 5294] 0 5294 1002 298 45056 0 -1000 sleep [ 303.102407] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=trinity-c1,pid=5039,uid=32 [ 303.120777] Out of memory: Killed process 5039 (trinity-c1) total-vm:52044kB, anon-rss:3624kB, file-rss:10700kB, shmem-rss:20340kB, UID:32 pgtables:156kB oom_score_adj:500 [ 303.129830] trinity-c5 invoked oom-killer: gfp_mask=0x400dc0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), order=0, oom_score_adj=500 [ 303.133891] CPU: 0 PID: 5238 Comm: trinity-c5 Not tainted 5.9.0-rc1-00605-g05b35e7eb9a1 #19 [ 303.135899] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1 04/01/2014 [ 303.138012] Call Trace: [ 303.138730] dump_stack+0x96/0xdb [ 303.139626] dump_header+0x4f/0x3f0 [ 303.140559] oom_kill_process+0xfa/0x210 [ 303.141597] out_of_memory+0x11a/0x620 [ 303.142581] __alloc_pages_slowpath.constprop.107+0xbaa/0xf70 [ 303.143944] __alloc_pages_nodemask+0x3b4/0x450 [ 303.145094] pte_alloc_one+0x13/0x70 [ 303.146034] do_fault+0x433/0x450 [ 303.146918] handle_mm_fault+0xa75/0xb40 [ 303.147919] ? exc_page_fault+0x167/0x6a0 [ 303.148956] exc_page_fault+0x37b/0x6a0 [ 303.149962] asm_exc_page_fault+0x1e/0x30 [ 303.150991] RIP: 0010:copy_user_generic_string+0x2c/0x40 [ 303.152254] Code: 00 83 fa 08 72 27 89 f9 83 e1 07 74 15 83 e9 08 f7 d9 29 ca 8a 06 88 07 48 ff c6 48 ff c7 ff c9 75 f2 89 d1 c1 e9 03 83 e2 07 48 a5 89 d1 f3 a4 31 c0 0f 1f 00 c3 0f 1f 80 00 00 00 00 0f 1f [ 303.156379] RSP: 0018:ffffb3fac1897ec0 EFLAGS: 00010246 [ 303.157629] RAX: 00007ffffffff000 RBX: 0000000000000009 RCX: 0000000000000002 [ 303.159238] RDX: 0000000000000000 RSI: 0000000000000009 RDI: ffffb3fac1897ee8 [ 303.160849] RBP: 0000000000000010 R08: 0000000000000000 R09: 0000000000000005 [ 303.162463] R10: 0000000000000000 R11: 0000000000000000 R12: ffffb3fac1897ee8 [ 303.164098] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 [ 303.165739] _copy_from_user+0x69/0xa0 [ 303.166721] get_timespec64+0x2a/0x80 [ 303.167671] ksys_semtimedop+0x35/0x80 [ 303.168637] ? syscall_enter_from_user_mode+0x26c/0x2a0 [ 303.169889] do_syscall_64+0x33/0x40 [ 303.170822] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 303.172036] RIP: 0033:0x463519 [ 303.172871] Code: 00 f3 c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 db 59 00 00 c3 66 2e 0f 1f 84 00 00 00 00 [ 303.176966] RSP: 002b:00007ffc345ba058 EFLAGS: 00000246 ORIG_RAX: 00000000000000dc [ 303.178795] RAX: ffffffffffffffda RBX: 00000000000000dc RCX: 0000000000463519 [ 303.180406] RDX: 0000000000000400 RSI: 0000000000000008 RDI: 000000008e8e8e8e [ 303.182018] RBP: 00007f69e5d6d000 R08: 0000000000000000 R09: 0000000000000048 [ 303.183627] R10: 0000000000000009 R11: 0000000000000246 R12: 0000000000000002 [ 303.185254] R13: 00007f69e5d6d058 R14: 0000000002cc3850 R15: 00007f69e5d6d000 [ 303.195287] Mem-Info: [ 303.196100] active_anon:7431 inactive_anon:1701643 isolated_anon:0 [ 303.196100] active_file:0 inactive_file:0 isolated_file:0 [ 303.196100] unevictable:12018 dirty:0 writeback:0 [ 303.196100] slab_reclaimable:12116 slab_unreclaimable:11762 [ 303.196100] mapped:10999 shmem:1706511 pagetables:295 bounce:0 [ 303.196100] free:24433 free_pcp:114 free_cma:0 [ 303.207878] Node 0 active_anon:29724kB inactive_anon:6806572kB active_file:0kB inactive_file:0kB unevictable:48072kB isolated(anon):0kB isolated(file):0kB mapped:43996kB dirty:0kB writeback:0kB shmem:6826044kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB kernel_stack:1552kB all_unreclaimable? yes [ 303.216005] Node 0 DMA free:14884kB min:148kB low:184kB high:220kB reserved_highatomic:0KB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 303.224008] lowmem_reserve[]: 0 2985 6917 6917 6917 [ 303.225785] Node 0 DMA32 free:44644kB min:29104kB low:36380kB high:43656kB reserved_highatomic:0KB active_anon:0kB inactive_anon:3010404kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:3129160kB managed:3063624kB mlocked:0kB pagetables:120kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 303.233906] lowmem_reserve[]: 0 0 3931 3931 3931 [ 303.235127] Node 0 Normal free:38204kB min:38328kB low:47908kB high:57488kB reserved_highatomic:0KB active_anon:29724kB inactive_anon:3795668kB active_file:0kB inactive_file:0kB unevictable:48472kB writepending:0kB present:4213760kB managed:4034136kB mlocked:552kB pagetables:1060kB bounce:0kB free_pcp:68kB local_pcp:0kB free_cma:0kB [ 303.243986] lowmem_reserve[]: 0 0 0 0 0 [ 303.245560] Node 0 DMA: 1*4kB (U) 0*8kB 0*16kB 1*32kB (U) 2*64kB (U) 1*128kB (U) 1*256kB (U) 0*512kB 0*1024kB 1*2048kB (M) 3*4096kB (M) = 14884kB [ 303.249723] Node 0 DMA32: 30*4kB (UM) 18*8kB (UME) 13*16kB (UME) 11*32kB (UM) 6*64kB (UME) 2*128kB (U) 2*256kB (ME) 2*512kB (UM) 3*1024kB (UME) 1*2048kB (M) 9*4096kB (M) = 44984kB [ 303.257225] Node 0 Normal: 560*4kB (UME) 365*8kB (UME) 555*16kB (UME) 300*32kB (UME) 135*64kB (UE) 40*128kB (UME) 6*256kB (UME) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 38936kB [ 303.264200] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 303.286442] 1718496 total pagecache pages [ 303.288554] 0 pages in swap cache [ 303.293152] Swap cache stats: add 0, delete 0, find 0/0 [ 303.302309] Free swap = 0kB [ 303.309848] Total swap = 0kB [ 303.310751] 1839728 pages RAM [ 303.320472] 0 pages HighMem/MovableOnly [ 303.324903] 61311 pages reserved [ 303.325786] 0 pages cma reserved [ 303.333651] 0 pages hwpoisoned [ 303.339237] Tasks state (memory values in pages): [ 303.346798] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 303.356577] [ 136] 0 136 922 547 49152 0 -1000 udevd [ 303.358666] [ 303] 0 303 1034 281 40960 0 0 syslogd [ 303.371113] [ 306] 0 306 1034 297 45056 0 0 klogd [ 303.373133] [ 312] 0 312 1034 35 49152 0 0 S77lkp-bootstra [ 303.381695] [ 314] 0 314 1066 592 45056 0 -1000 lkp-setup-rootf [ 303.393824] [ 325] 0 325 1034 538 49152 0 0 start_getty [ 303.404634] [ 327] 0 327 1034 283 40960 0 0 getty [ 303.406691] [ 339] 0 339 1034 285 49152 0 -1000 tail [ 303.420221] [ 378] 0 378 1034 283 40960 0 0 getty [ 303.422228] [ 431] 0 431 1069 608 40960 0 -1000 run-lkp [ 303.436034] [ 521] 0 521 1002 285 40960 0 0 cat [ 303.443862] [ 526] 0 526 617 220 45056 0 0 vmstat [ 303.451385] [ 545] 0 545 1035 283 45056 0 0 watchdog [ 303.459573] [ 554] 0 554 270 2 32768 0 0 wait [ 303.461606] [ 564] 0 564 270 14 32768 0 0 wakeup [ 303.475398] [ 575] 0 575 270 14 32768 0 0 wakeup [ 303.481991] [ 586] 0 586 1002 301 49152 0 0 cat [ 303.491185] [ 588] 0 588 1002 284 45056 0 0 cat [ 303.497402] [ 645] 0 645 1035 610 45056 0 0 trinity [ 303.507390] [ 648] 0 648 1035 301 49152 0 0 tee [ 303.515367] [ 657] 0 657 1035 35 45056 0 0 trinity [ 303.523448] [ 658] 0 658 1002 284 40960 0 0 sleep [ 303.527337] [ 660] 0 660 13180 9311 163840 0 0 trinity-main [ 303.537875] [ 5159] 512 5159 13199 7118 155648 0 500 trinity-c0 [ 303.545341] [ 5184] -2 5184 13246 8649 151552 0 500 trinity-c7 [ 303.552133] [ 5238] 200 5238 13663 7450 159744 0 500 trinity-c5 [ 303.559910] [ 5255] 216160412 5255 13184 6280 151552 0 500 trinity-c6 [ 303.562039] [ 5288] 0 5288 1035 552 45056 0 -1000 post-run [ 303.568624] [ 5290] 0 5290 270 15 32768 0 -1000 wakeup [ 303.579440] [ 5292] 0 5292 270 15 32768 0 -1000 wakeup [ 303.588450] [ 5295] 0 5295 13180 3331 98304 0 0 trinity-main [ 303.595273] oom-kill:constraint=CONSTRAINT_NONE,nodemask=(null),cpuset=/,mems_allowed=0,global_oom,task_memcg=/,task=trinity-c7,pid=5184,uid=-2 [ 303.605412] Out of memory: Killed process 5184 (trinity-c7) total-vm:52984kB, anon-rss:3708kB, file-rss:10700kB, shmem-rss:20188kB, UID:4294967294 pgtables:148kB oom_score_adj:500 [ 303.616604] oom_reaper: reaped process 5184 (trinity-c7), now anon-rss:0kB, file-rss:0kB, shmem-rss:20188kB [ 305.735807] audit: type=1326 audit(306.102:54): auid=4294967295 uid=4294967290 gid=0 ses=4294967295 pid=5297 comm="trinity-c2" exe="/bin/trinity" sig=9 arch=c000003e syscall=8 compat=0 ip=0x464597 code=0x0 [ 305.998204] sysrq: Emergency Sync [ 306.001401] Emergency Sync complete [ 306.002774] sysrq: Resetting