Subject: [lkp-robot] [socket] 3e6168eaff: BUG:using__this_cpu_add()in_preemptible[#]code:swapper

From: kernel test robot <[email-masked]>
Date: Fri, 17 Nov 2017 10:25:56 +0800

FYI, we noticed the following commit (built with gcc-6):

commit: 3e6168eaff5c9c49668c0af781732cf4245d9459 ("socket: Move the socket inuse to namespace.")
url: https://github.com/0day-ci/linux/commits/Tonghao-Zhang/socket-Move-the-socket-inuse-to-namespace/20171116-080523

in testcase: boot

on test machine: qemu-system-x86_64 -enable-kvm -smp 2 -m 420M

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):

+---------------------------------------------------------+------------+------------+
|                                                         | 2798b80b38 | 3e6168eaff |
+---------------------------------------------------------+------------+------------+
| boot_successes                                          | 5          | 2          |
| boot_failures                                           | 36         | 44         |
| IP-Config:Auto-configuration_of_network_failed          | 36         |            |
| BUG:using__this_cpu_add()in_preemptible[#]code:swapper  | 0          | 44         |
| BUG:using__this_cpu_add()in_preemptible[#]code:init     | 0          | 16         |
| BUG:using__this_cpu_add()in_preemptible[#]code:rc.local | 0          | 14         |
| BUG:using__this_cpu_add()in_preemptible[#]code:sh       | 0          | 13         |
| BUG:using__this_cpu_add()in_preemptible[#]code:udevd    | 0          | 5          |
| BUG:using__this_cpu_add()in_preemptible[#]code:getent   | 0          | 1          |
| BUG:using__this_cpu_add()in_preemptible[#]code:groupadd | 0          | 1          |
| BUG:using__this_cpu_add()in_preemptible[#]code:ifconfig | 0          | 13         |
| BUG:using__this_cpu_add()in_preemptible[#]code:ip       | 0          | 13         |
| BUG:using__this_cpu_add()in_preemptible[#]code:adduser  | 0          | 1          |
| BUG:using__this_cpu_add()in_preemptible[#]code:addgroup | 0          | 1          |
| BUG:using__this_cpu_add()in_preemptible[#]code:useradd  | 0          | 1          |
+---------------------------------------------------------+------------+------------+

[    0.217996] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    0.219513] caller is __this_cpu_preempt_check+0x13/0x15
[    0.220005] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    0.221493] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.223054] Call Trace:
[    0.223701]  dump_stack+0x63/0x7f
[    0.224000]  check_preemption_disabled+0xf2/0x104
[    0.224000]  __this_cpu_preempt_check+0x13/0x15
[    0.224000]  sock_alloc+0x8c/0xa1
[    0.224000]  sock_create_lite+0x17/0x33
[    0.224000]  __netlink_kernel_create+0x7d/0x1fc
[    0.224000]  rtnetlink_net_init+0x54/0x70
[    0.224000]  ? rtnetlink_net_exit+0x27/0x27
[    0.224000]  ? do_set_master+0x9b/0x9b
[    0.224000]  ops_init+0x100/0x12c
[    0.224000]  register_pernet_operations+0xd0/0x16c
[    0.224000]  register_pernet_subsys+0x29/0x3f
[    0.224000]  rtnetlink_init+0x2d/0x1b7
[    0.224000]  netlink_proto_init+0x14d/0x167
[    0.224000]  ? snap_init+0x3d/0x3d
[    0.224000]  ? do_early_param+0x92/0x92
[    0.224000]  do_one_initcall+0x9f/0x189
[    0.224000]  ? do_early_param+0x92/0x92
[    0.224000]  kernel_init_freeable+0x166/0x1e9
[    0.224000]  ? rest_init+0xc6/0xc6
[    0.224000]  kernel_init+0xe/0xf5
[    0.224000]  ret_from_fork+0x25/0x30
[    0.224742] cpuidle: using governor menu
[    0.228007] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    0.229523] caller is __this_cpu_preempt_check+0x13/0x15
[    0.230464] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    0.231954] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.232000] Call Trace:
[    0.232000]  dump_stack+0x63/0x7f
[    0.232000]  check_preemption_disabled+0xf2/0x104
[    0.232000]  __this_cpu_preempt_check+0x13/0x15
[    0.232000]  sock_alloc+0x8c/0xa1
[    0.232000]  sock_create_lite+0x17/0x33
[    0.232000]  __netlink_kernel_create+0x7d/0x1fc
[    0.232000]  uevent_net_init+0x5f/0xc2
[    0.232000]  ops_init+0x100/0x12c
[    0.232000]  ? do_early_param+0x92/0x92
[    0.232000]  register_pernet_operations+0xd0/0x16c
[    0.232000]  register_pernet_subsys+0x29/0x3f
[    0.232000]  ? ioremap_huge_init+0x35/0x35
[    0.232000]  kobject_uevent_init+0x10/0x12
[    0.232000]  do_one_initcall+0x9f/0x189
[    0.232000]  ? do_early_param+0x92/0x92
[    0.232000]  kernel_init_freeable+0x166/0x1e9
[    0.232000]  ? rest_init+0xc6/0xc6
[    0.232000]  kernel_init+0xe/0xf5
[    0.232000]  ret_from_fork+0x25/0x30
[    0.232605] ACPI: bus type PCI registered
[    0.233432] PCI: Using configuration type 1 for base access
[    0.308039] raid6: sse2x1   gen()  6435 MB/s
[    0.380542] raid6: sse2x1   xor()  5940 MB/s
[    0.448012] raid6: sse2x2   gen()  9031 MB/s
[    0.516008] raid6: sse2x2   xor()  7115 MB/s
[    0.584010] raid6: sse2x4   gen() 10337 MB/s
[    0.652007] raid6: sse2x4   xor()  7468 MB/s
[    0.652872] raid6: using algorithm sse2x4 gen() 10337 MB/s
[    0.653833] raid6: .... xor() 7468 MB/s, rmw enabled
[    0.654737] raid6: using intx1 recovery algorithm
[    0.656228] ACPI: Added _OSI(Module Device)
[    0.660005] ACPI: Added _OSI(Processor Device)
[    0.664004] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.664884] ACPI: Added _OSI(Processor Aggregator Device)
[    0.668398] ACPI: Interpreter enabled
[    0.669179] ACPI: (supports S0 S3 S5)
[    0.669929] ACPI: Using IOAPIC for interrupt routing
[    0.670842] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.672178] ACPI: Enabled 2 GPEs in block 00 to 0F
[    0.679048] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.680009] acpi PNP0A03:00: _OSC: OS supports [Segments]
[    0.680974] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[    0.682123] PCI host bridge to bus 0000:00
[    0.682936] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    0.684006] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    0.685122] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    0.686573] pci_bus 0000:00: root bus resource [mem 0x1a400000-0xfebfffff window]
[    0.688006] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.689055] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.690501] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.692268] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.696006] pci 0000:00:01.1: reg 0x20: [io  0xc040-0xc04f]
[    0.698367] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    0.699525] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    0.700005] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    0.701161] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    0.702451] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.704357] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    0.705802] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    0.707203] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    0.709523] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    0.713172] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    0.719641] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    0.720289] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.722591] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    0.724883] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    0.731476] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    0.732318] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000
[    0.734009] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f]
[    0.740217] pci_bus 0000:00: on NUMA node 0
[    0.741596] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.742729] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.743834] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.744120] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.745516] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.746882] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    0.746882] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    0.748007] pci 0000:00:02.0: vgaarb: bridge control possible
[    0.749000] vgaarb: loaded
[    0.752008] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    0.753497] caller is __this_cpu_preempt_check+0x13/0x15
[    0.754434] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    0.755895] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.756000] Call Trace:
[    0.756000]  dump_stack+0x63/0x7f
[    0.756000]  check_preemption_disabled+0xf2/0x104
[    0.756000]  ? do_early_param+0x92/0x92
[    0.756000]  __this_cpu_preempt_check+0x13/0x15
[    0.756000]  sock_alloc+0x8c/0xa1
[    0.756000]  sock_create_lite+0x17/0x33
[    0.756000]  __netlink_kernel_create+0x7d/0x1fc
[    0.756000]  ? cn_rx_skb+0x101/0x101
[    0.756000]  ? do_early_param+0x92/0x92
[    0.756000]  cn_init+0x43/0xb1
[    0.756000]  ? cn_fini+0x40/0x40
[    0.756000]  do_one_initcall+0x9f/0x189
[    0.756000]  ? do_early_param+0x92/0x92
[    0.756000]  kernel_init_freeable+0x166/0x1e9
[    0.756000]  ? rest_init+0xc6/0xc6
[    0.756000]  kernel_init+0xe/0xf5
[    0.756000]  ret_from_fork+0x25/0x30
[    0.756232] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    0.760006] caller is __this_cpu_preempt_check+0x13/0x15
[    0.760962] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    0.762435] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.763996] Call Trace:
[    0.764000]  dump_stack+0x63/0x7f
[    0.764000]  check_preemption_disabled+0xf2/0x104
[    0.764000]  ? do_early_param+0x92/0x92
[    0.764000]  __this_cpu_preempt_check+0x13/0x15
[    0.764000]  sock_alloc+0x8c/0xa1
[    0.764000]  sock_create_lite+0x17/0x33
[    0.764000]  __netlink_kernel_create+0x7d/0x1fc
[    0.764000]  ? do_early_param+0x92/0x92
[    0.764000]  scsi_netlink_init+0x40/0x61
[    0.764000]  ? scsi_exit_devinfo+0x20/0x20
[    0.764000]  init_scsi+0x51/0x8d
[    0.764000]  ? trace_event_define_fields_scsi_cmd_done_timeout_template+0x203/0x203
[    0.764000]  do_one_initcall+0x9f/0x189
[    0.764000]  ? do_early_param+0x92/0x92
[    0.764000]  kernel_init_freeable+0x166/0x1e9
[    0.764000]  ? rest_init+0xc6/0xc6
[    0.764000]  kernel_init+0xe/0xf5
[    0.764000]  ret_from_fork+0x25/0x30
[    0.764010] SCSI subsystem initialized
[    0.764849] pps_core: LinuxPPS API ver. 1 registered
[    0.765751] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <[email-masked]>
[    0.767403] PTP clock support registered
[    0.768075] FPGA manager framework
[    0.768822] Advanced Linux Sound Architecture Driver Initialized.
[    0.769852] PCI: Using ACPI for IRQ routing
[    0.770716] PCI: pci_cache_line_size set to 64 bytes
[    0.772103] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.773146] e820: reserve RAM buffer [mem 0x1a3e0000-0x1bffffff]
[    0.774293] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    0.775772] caller is __this_cpu_preempt_check+0x13/0x15
[    0.776005] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    0.777482] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    0.779030] Call Trace:
[    0.779648]  dump_stack+0x63/0x7f
[    0.780000]  check_preemption_disabled+0xf2/0x104
[    0.780000]  __this_cpu_preempt_check+0x13/0x15
[    0.780000]  sock_alloc+0x8c/0xa1
[    0.780000]  sock_create_lite+0x17/0x33
[    0.780000]  __netlink_kernel_create+0x7d/0x1fc
[    0.780000]  genl_pernet_init+0x50/0x81
[    0.780000]  ? genl_bind+0x9d/0x9d
[    0.780000]  ? genl_unbind+0x75/0x75
[    0.780000]  ? genl_pernet_exit+0x27/0x27
[    0.780000]  ops_init+0x100/0x12c
[    0.780000]  ? do_early_param+0x92/0x92
[    0.780000]  register_pernet_operations+0xd0/0x16c
[    0.780000]  register_pernet_subsys+0x29/0x3f
[    0.780000]  ? netlink_proto_init+0x167/0x167
[    0.780000]  genl_init+0x25/0x3b
[    0.780000]  do_one_initcall+0x9f/0x189
[    0.780000]  ? do_early_param+0x92/0x92
[    0.780000]  kernel_init_freeable+0x166/0x1e9
[    0.780000]  ? rest_init+0xc6/0xc6
[    0.780000]  kernel_init+0xe/0xf5
[    0.780000]  ret_from_fork+0x25/0x30
[    0.780007] Bluetooth: Core ver 2.22
[    0.780762] NET: Registered protocol family 31
[    0.781652] Bluetooth: HCI device and connection manager initialized
[    0.784007] Bluetooth: HCI socket layer initialized
[    0.784907] Bluetooth: L2CAP socket layer initialized
[    0.785835] Bluetooth: SCO socket layer initialized
[    0.786729] NET: Registered protocol family 8
[    0.788004] NET: Registered protocol family 20
[    0.788903] nfc: nfc_init: NFC Core ver 0.1
[    0.788903] NET: Registered protocol family 39
[    0.789792] clocksource: Switched to clocksource kvm-clock
[    0.795072] Warning: could not register annotated branches stats
[    0.808219] VFS: Disk quotas dquot_6.6.0
[    0.809078] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    0.810283] FS-Cache: Loaded
[    0.811226] CacheFiles: Loaded
[    0.811951] pnp: PnP ACPI init
[    0.812790] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.813935] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.815064] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.816192] pnp 00:03: [dma 2]
[    0.816911] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.818078] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.819261] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.820444] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.821815] pnp: PnP ACPI: found 7 devices
[    0.832302] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    0.833968] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    0.835012] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    0.836066] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    0.837190] pci_bus 0000:00: resource 7 [mem 0x1a400000-0xfebfffff window]
[    0.838372] NET: Registered protocol family 1
[    0.839219] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.847073] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.848101] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.849176] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.850797] PCI: CLS 0 bytes, default 64
[    0.851658] Trying to unpack rootfs image as initramfs...
[    1.041379] Freeing initrd memory: 2444K
[    1.044983] PCLMULQDQ-NI instructions are not detected.
[    1.045936] AVX or AES-NI instructions are not detected.
[    1.046883] CPU feature 'AVX registers' is not supported.
[    1.047833] CPU feature 'AVX registers' is not supported.
[    1.048875] AVX2 or AES-NI instructions are not detected.
[    1.049869] AVX2 instructions are not detected.
[    2.048082] tsc: Refined TSC clocksource calibration: 2925.994 MHz
[    2.049829] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2a2d2ead42f, max_idle_ns: 440795314183 ns
[    7.634926] audit: initializing netlink subsys (disabled)
[    7.636708] BUG: using __this_cpu_add() in preemptible [00000000] code: swapper/0/1
[    7.639235] caller is __this_cpu_preempt_check+0x13/0x15
[    7.640827] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.14.0-rc7-02177-g3e6168e #1
[    7.643228] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[    7.644814] Call Trace:
[    7.644814]  dump_stack+0x63/0x7f
[    7.644814]  check_preemption_disabled+0xf2/0x104
[    7.644814]  __this_cpu_preempt_check+0x13/0x15
[    7.644814]  sock_alloc+0x8c/0xa1
[    7.644814]  sock_create_lite+0x17/0x33
[    7.644814]  __netlink_kernel_create+0x7d/0x1fc
[    7.644814]  audit_net_init+0x6d/0xa4
[    7.644814]  ? audit_receive_msg+0xb76/0xb76
[    7.644814]  ? audit_net_exit+0x38/0x38
[    7.644814]  ops_init+0x100/0x12c
[    7.644814]  ? do_early_param+0x92/0x92
[    7.644814]  register_pernet_operations+0xd0/0x16c
[    7.644814]  register_pernet_subsys+0x29/0x3f
[    7.644814]  ? audit_backlog_limit_set+0x61/0x61
[    7.644814]  audit_init+0x103/0x1a2
[    7.644814]  ? audit_backlog_limit_set+0x61/0x61
[    7.644814]  do_one_initcall+0x9f/0x189
[    7.644814]  ? do_early_param+0x92/0x92
[    7.644814]  kernel_init_freeable+0x166/0x1e9
[    7.644814]  ? rest_init+0xc6/0xc6
[    7.644814]  kernel_init+0xe/0xf5
[    7.644814]  ret_from_fork+0x25/0x30
[    7.676827] audit: type=2000 audit(1510847326.601:1): state=initialized audit_enabled=0 res=1
[    7.677460] Initialise system trusted keyrings
[    7.677471] Key type blacklist registered
[    7.677562] workingset: timestamp_bits=46 max_order=17 bucket_order=0
[    7.679363] zbud: loaded
[    7.680065] efs: 1.0a - http://aeschi.ch.eu.org/efs/
[    7.680213] qnx6: QNX6 filesystem 1.0.0 registered.
[    7.680261] fuse init (API version 7.26)
[    7.680357] JFS: nTxBlock = 3092, nTxLock = 24738
[    7.689297] SGI XFS with security attributes, no debug enabled
[    7.691502] NILFS version 2 loaded
[    7.692781] befs: version: 0.9.3
[    7.698575] NET: Registered protocol family 38
[    7.700131] Key type asymmetric registered
[    7.701496] Asymmetric key parser 'x509' registered
[    7.703030] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    7.705540] io scheduler noop registered
[    7.706903] io scheduler cfq registered (default)
[    7.708389] io scheduler mq-deadline registered
[    7.709852] io scheduler bfq registered
[    7.711169] test_string_helpers: Running tests...
[    7.715182] test_hexdump: all 1184 tests passed
[    7.720042] test_firmware: interface ready
[    7.732819] test_hash: __hash_32() has no arch implementation to test.
[    7.734650] test_hash: hash_32() has no arch implementation to test.
[    7.736467] test_hash: hash_64() has no arch implementation to test.
[    7.738249] test_hash: 33152 tests passed.
[    7.739673] test_siphash: self-tests: pass
[    7.741443] Running rhashtable test nelem=8, max_size=0, shrinking=0
[    7.742985] Test 00:
[    7.743622]   Adding 50000 keys
[    7.769264]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.779240]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.780837]   Deleting 50000 keys
[    7.793154]   Duration of test: 48826728 ns
[    7.794507] Test 01:
[    7.795569]   Adding 50000 keys
[    7.828058]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.836850]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.839012]   Deleting 50000 keys
[    7.859138]   Duration of test: 62393287 ns
[    7.860511] Test 02:
[    7.861557]   Adding 50000 keys
[    7.890550]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.902615]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.905084]   Deleting 50000 keys
[    7.924891]   Duration of test: 62188477 ns
[    7.926173] Test 03:
[    7.927162]   Adding 50000 keys
[    7.972452]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.984527]   Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[    7.986992]   Deleting 50000 keys
[    8.007201]   Duration of test: 78946591 ns
[    8.016728] test if its possible to exceed max_size 8192: no, ok
[    8.018348] Average test time: 63088770
[    8.019580] Testing concurrent rhashtable access from 10 threads
[    9.630718] test 3125 add/delete pairs into rhlist
[    9.736812] test 3125 random rhlist add/delete operations
[    9.756386] Started 10 threads, 0 failed, rhltable test returns 0
[    9.757605] test_printf: all 260 tests passed
[    9.890152] test_bitmap: test 13: input is '0-2047:128/256' OK, Time: 1414
[    9.898763] test_bitmap: all 460506 tests passed
[    9.900584] crc32: CRC_LE_BITS = 32, CRC_BE BITS = 32
[    9.901992] crc32: self tests passed, processed 225944 bytes in 210059 nsec
[    9.904056] crc32c: CRC_LE_BITS = 32
[    9.905240] crc32c: self tests passed, processed 225944 bytes in 113126 nsec
[    9.925881] crc32_combine: 8373 self tests passed
[    9.946125] crc32c_combine: 8373 self tests passed
[    9.948052] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    9.949943] glob: 64 self-tests passed, 0 failed
[    9.951572] gpio_it87: no device
[    9.952918] gpio-mockup: probe of gpio-mockup failed with error -22
[    9.956191] no IO addresses supplied
[    9.957517] hgafb: HGA card not detected.

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,
Xiaolong