FYI, we noticed the following commit (built with gcc-4.9):
commit: cb9cc5caafb2b2ad1db9742432754913d36f9cec ("mm: initialize pages on demand
during boot")
git://git.cmpxchg.org/linux-mmotm.git master
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url:
http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 1G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------------------------+------------+------------+
| | ee4fbdc56f
| cb9cc5caaf |
+-----------------------------------------------------------------------------+------------+------------+
| boot_successes | 8
| 0 |
| boot_failures | 0
| 8 |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c | 0
| 8 |
+-----------------------------------------------------------------------------+------------+------------+
[ 0.046841] BUG: sleeping function called from invalid context at
kernel/locking/mutex.c:747
[ 0.048069] in_atomic(): 1, irqs_disabled(): 0, pid: 1, name: swapper/0
[ 0.048731] 1 lock held by swapper/0/1:
[ 0.049191] #0: (deferred_zone_grow_lock){....}, at: [<00000000a84c7c0f>]
page_alloc_init_late+0x19/0xf4
[ 0.050019] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.16.0-rc2-mm1-00042-gcb9cc5c #1
[ 0.051072] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1
04/01/2014
[ 0.052174] Call Trace:
[ 0.052511] dump_stack+0x5c/0x7d
[ 0.052961] ___might_sleep+0xfe/0x120
[ 0.053333] __mutex_lock+0x54/0x920
[ 0.053333] ? ret_from_fork+0x35/0x40
[ 0.053333] ? find_held_lock+0x38/0xa0
[ 0.053333] ? static_key_disable_cpuslocked+0x2c/0x70
[ 0.053333] static_key_disable_cpuslocked+0x2c/0x70
[ 0.053333] page_alloc_init_late+0x25/0xf4
[ 0.053333] kernel_init_freeable+0x129/0x23d
[ 0.053333] ? rest_init+0x100/0x100
[ 0.053333] kernel_init+0x5/0x100
[ 0.053333] ret_from_fork+0x35/0x40
[ 0.139999] node 0 initialised, 155246 pages in 86ms
[ 0.146928] devtmpfs: initialized
[ 0.149084] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns:
6370867519511994 ns
[ 0.150034] futex hash table entries: 16 (order: -1, 2048 bytes)
[ 0.150942] xor: automatically using best checksumming function avx
[ 0.151852] pinctrl core: initialized pinctrl subsystem
[ 0.153183] NET: Registered protocol family 16
[ 0.154520] audit: initializing netlink subsys (disabled)
[ 0.155375] audit: type=2000 audit(1519791676.541:1): state=initialized audit_enabled=0
res=1
[ 0.155375] cpuidle: using governor menu
[ 0.157750] ACPI: bus type PCI registered
[ 0.158341] dca service started, version 1.12.1
[ 0.158987] PCI: Using configuration type 1 for base access
[ 0.187303] cryptd: max_cpu_qlen set to 1000
[ 0.243360] raid6: sse2x1 gen() 5114 MB/s
[ 0.300041] raid6: sse2x1 xor() 4184 MB/s
[ 0.356687] raid6: sse2x2 gen() 7241 MB/s
[ 0.413353] raid6: sse2x2 xor() 4964 MB/s
[ 0.470017] raid6: sse2x4 gen() 8703 MB/s
[ 0.526685] raid6: sse2x4 xor() 5517 MB/s
[ 0.583352] raid6: avx2x1 gen() 8967 MB/s
[ 0.640017] raid6: avx2x1 xor() 7215 MB/s
[ 0.696698] raid6: avx2x2 gen() 12965 MB/s
[ 0.753355] raid6: avx2x2 xor() 11309 MB/s
[ 0.810018] raid6: avx2x4 gen() 13942 MB/s
[ 0.866682] raid6: avx2x4 xor() 8612 MB/s
[ 0.867191] raid6: using algorithm avx2x4 gen() 13942 MB/s
[ 0.867818] raid6: .... xor() 8612 MB/s, rmw enabled
[ 0.868382] raid6: using avx2x2 recovery algorithm
[ 0.869538] ACPI: Added _OSI(Module Device)
[ 0.870030] ACPI: Added _OSI(Processor Device)
[ 0.870546] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.871278] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.877562] ACPI: Interpreter enabled
[ 0.878027] ACPI: (supports S0 S5)
[ 0.878452] ACPI: Using IOAPIC for interrupt routing
[ 0.879536] PCI: Using host bridge windows from ACPI; if necessary, use
"pci=nocrs" and report a bug
[ 0.880489] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 0.890221] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.890940] acpi PNP0A03:00: _OSC: OS supports [Segments MSI]
[ 0.891683] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.892660] PCI host bridge to bus 0000:00
[ 0.893135] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.893351] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.894106] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.894929] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
[ 0.895755] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.896530] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 0.897591] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 0.899201] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 0.903831] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f]
[ 0.906339] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.906688] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.907456] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.908291] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.910201] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 0.911325] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 0.912135] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 0.913545] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 0.920036] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 0.925641] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[ 0.934899] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 0.936236] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 0.938070] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 0.940025] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 0.950845] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 0.952156] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000
[ 0.953804] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f]
[ 0.961181] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[ 0.961852] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[ 0.962480] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[ 0.963086] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[ 0.963445] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[ 0.964754] SCSI subsystem initialized
[ 0.964754] libata version 3.00 loaded.
[ 0.964754] pps_core: LinuxPPS API ver. 1 registered
[ 0.966686] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti
<giometti(a)linux.it>
[ 0.967764] PTP clock support registered
[ 0.969504] EDAC MC: Ver: 3.0.0
[ 0.970351] FPGA manager framework
[ 0.970570] PCI: Using ACPI for IRQ routing
[ 0.970570] PCI: pci_cache_line_size set to 64 bytes
To reproduce:
git clone
https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this
email
Thanks,
lkp