lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Date:   Mon, 17 Feb 2020 08:34:44 +0800
From:   kernel test robot <lkp@...el.com>
To:     Masami Hiramatsu <mhiramat@...nel.org>
Cc:     0day robot <lkp@...el.com>, LKML <linux-kernel@...r.kernel.org>,
        lkp@...ts.01.org
Subject: [tracing] 1b6c0739c6:
 BUG:sleeping_function_called_from_invalid_context_at_mm/page_alloc.c

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

commit: 1b6c0739c611f3b5373e27571cc93064c423731d ("tracing: Skip software disabled event at __synth_event_trace_end()")
https://github.com/0day-ci/linux/commits/Masami-Hiramatsu/tracing-Skip-software-disabled-event-at-__synth_event_trace_end/20200215-100354

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 SandyBridge -smp 2 -m 8G

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


+-----------------------------------------------------------------------------+------------+------------+
|                                                                             | 7276531d40 | 1b6c0739c6 |
+-----------------------------------------------------------------------------+------------+------------+
| boot_successes                                                              | 22         | 0          |
| boot_failures                                                               | 0          | 22         |
| BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c | 0          | 6          |
| initcall_synth_event_gen_test_init_returned_with_preemption_imbalance       | 0          | 22         |
| WARNING:at_init/main.c:#do_one_initcall                                     | 0          | 22         |
| RIP:do_one_initcall                                                         | 0          | 22         |
| BUG:sleeping_function_called_from_invalid_context_at_mm/page_alloc.c        | 0          | 16         |
+-----------------------------------------------------------------------------+------------+------------+


If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp@...el.com>


[    6.998544] BUG: sleeping function called from invalid context at mm/page_alloc.c:4695
[    7.000227] in_atomic(): 1, irqs_disabled(): 0, non_block: 0, pid: 1, name: swapper/0
[    7.001487] no locks held by swapper/0/1.
[    7.002172] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.5.0-rc6-00098-g1b6c0739c611f #2
[    7.003522] Call Trace:
[    7.003962]  dump_stack+0x57/0x75
[    7.004179]  ___might_sleep+0x111/0x120
[    7.004179]  __might_sleep+0x68/0x70
[    7.004179]  __alloc_pages_nodemask+0xe9/0x250
[    7.004179]  ? test_empty_synth_event+0x1f/0x222
[    7.004179]  slob_new_pages+0x13/0xa0
[    7.004179]  slob_alloc+0x2b8/0x2e0
[    7.004179]  ? test_empty_synth_event+0x1f/0x222
[    7.004179]  __kmalloc+0x1cd/0x1f0
[    7.004179]  ? test_empty_synth_event+0x222/0x222
[    7.004179]  ? do_early_param+0x92/0x92
[    7.004179]  test_empty_synth_event+0x1f/0x222
[    7.004179]  ? print_synth_event+0x2c0/0x2c0
[    7.004179]  ? test_empty_synth_event+0x222/0x222
[    7.004179]  synth_event_gen_test_init+0x1d/0x3bd
[    7.004179]  ? init_tracepoints+0x28/0x28
[    7.004179]  ? do_early_param+0x92/0x92
[    7.004179]  ? proc_create_data+0x3b/0x50
[    7.004179]  ? proc_create+0xf/0x20
[    7.004179]  do_one_initcall+0xae/0x210
[    7.004179]  kernel_init_freeable+0x1e4/0x25c
[    7.004179]  ? rest_init+0x140/0x140
[    7.004179]  kernel_init+0x9/0x100
[    7.004179]  ret_from_fork+0x35/0x40
[    7.026429] ------------[ cut here ]------------
[    7.027238] initcall synth_event_gen_test_init+0x0/0x3bd returned with preemption imbalance 
[    7.028721] WARNING: CPU: 0 PID: 1 at init/main.c:1159 do_one_initcall+0x1c4/0x210
[    7.030508] Modules linked in:
[    7.031114] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G        W         5.5.0-rc6-00098-g1b6c0739c611f #2
[    7.032901] RIP: 0010:do_one_initcall+0x1c4/0x210
[    7.033805] Code: 40 00 00 00 48 c7 c6 a6 7a e2 81 e8 86 91 70 00 fb 80 7d a0 00 74 1d 48 8d 55 a0 4c 89 e6 48 c7 c7 b0 7e e2 81 e8 fc b2 09 00 <0f> 0b eb 06 41 bd ff ff ff ff 48 83 c4 40 44 89 e8 5b 41 5c 41 5d
[    7.035098] RSP: 0000:ffffc90000013e98 EFLAGS: 00010292
[    7.035098] RAX: 0000000000000050 RBX: 0000000000000000 RCX: 0000000000000000
[    7.035098] RDX: 0000000000000000 RSI: 00000001a2f14e6c RDI: ffffffff82054880
[    7.035098] RBP: ffffc90000013ef8 R08: 0000000000000001 R09: 0000000000000001
[    7.035098] R10: 0000000000000010 R11: 0000000000000000 R12: ffffffff824b1bab
[    7.035098] R13: 0000000000000000 R14: 0000000000000007 R15: ffffffff8248f6fd
[    7.035098] FS:  0000000000000000(0000) GS:ffff888236a00000(0000) knlGS:0000000000000000
[    7.035098] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[    7.035098] CR2: 0000000000000000 CR3: 0000000002012000 CR4: 00000000000406f0
[    7.035098] Call Trace:
[    7.035098]  kernel_init_freeable+0x1e4/0x25c
[    7.035098]  ? rest_init+0x140/0x140
[    7.035098]  kernel_init+0x9/0x100
[    7.035098]  ret_from_fork+0x35/0x40
[    7.035098] ---[ end trace 0953bc968f723b18 ]---


To reproduce:

        # build kernel
	cd linux
	cp config-5.5.0-rc6-00098-g1b6c0739c611f .config
	make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage

        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


View attachment "config-5.5.0-rc6-00098-g1b6c0739c611f" of type "text/plain" (116369 bytes)

View attachment "job-script" of type "text/plain" (4558 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (24328 bytes)

Powered by blists - more mailing lists