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  linux-cve-announce  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]
Message-ID: <20180823023839.GA13343@shao2-debian>
Date:   Thu, 23 Aug 2018 10:38:39 +0800
From:   kernel test robot <rong.a.chen@...el.com>
To:     Joel Fernandes <joel@...lfernandes.org>
Cc:     Steven Rostedt <rostedt@...dmis.org>,
        Peter Zijlstra <peterz@...radead.org>,
        Namhyung Kim <namhyung@...nel.org>,
        LKML <linux-kernel@...r.kernel.org>, lkp@...org
Subject: [lkp-robot] [tracing]  c3bc8fd637:
 WARNING:at_kernel/rcu/tree.c:#rcu_irq_enter

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

commit: c3bc8fd637a9623f5c507bd18f9677effbddf584 ("tracing: Centralize preemptirq tracepoints and unify their usage")
https://git.kernel.org/cgit/linux/kernel/git/rostedt/linux-trace.git ftrace/core

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 4G

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


+------------------------------------------------------------------+------------+------------+
|                                                                  | e6753f23d9 | c3bc8fd637 |
+------------------------------------------------------------------+------------+------------+
| boot_successes                                                   | 19         | 4          |
| boot_failures                                                    | 2          | 15         |
| invoked_oom-killer:gfp_mask=0x                                   | 2          | 3          |
| Mem-Info                                                         | 2          | 3          |
| Out_of_memory:Kill_process                                       | 1          | 3          |
| RIP:copy_user_generic_string                                     | 1          | 1          |
| RIP:__clear_user                                                 | 1          |            |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 1          | 1          |
| WARNING:at_kernel/rcu/tree.c:#rcu_irq_enter                      | 0          | 12         |
| RIP:rcu_irq_enter                                                | 0          | 12         |
| RIP:arch_local_irq_restore                                       | 0          | 12         |
| WARNING:at_kernel/events/core.c:#perf_event_task_tick            | 0          | 12         |
| RIP:perf_event_task_tick                                         | 0          | 12         |
| WARNING:at_kernel/rcu/tree.c:#rcu_irq_exit                       | 0          | 11         |
| RIP:rcu_irq_exit                                                 | 0          | 11         |
| RIP:check_poison_obj                                             | 0          | 1          |
| RIP:get_page_from_freelist                                       | 0          | 1          |
| RIP:locks_remove_posix                                           | 0          | 1          |
+------------------------------------------------------------------+------------+------------+



[   11.209512] WARNING: CPU: 0 PID: 24 at kernel/rcu/tree.c:999 rcu_irq_enter+0x55/0x77
[   11.209512] CPU: 0 PID: 24 Comm: kworker/0:1 Tainted: G                T 4.18.0-rc6-00023-gc3bc8fd #1
[   11.209512] Workqueue: events test_mutex_work
[   11.209512] RIP: 0010:rcu_irq_enter+0x55/0x77
[   11.209512] Code: 00 00 00 75 27 83 b8 d8 0a 00 00 00 74 1e 80 3d 48 e3 f0 01 00 75 15 48 c7 c7 1a 1a 8b 82 c6 05 38 e3 f0 01 01 e8 fc f5 f9 ff <0f> 0b 48 83 7b 08 00 75 13 65 48 8b 04 25 c0 4e 01 00 c7 80 40 19 
[   11.209512] RSP: 0000:ffff88013f403fc8 EFLAGS: 00010082
[   11.209512] RAX: 0000000000000000 RBX: ffff88013f419c60 RCX: ffff88013f403e44
[   11.209512] RDX: 0000000000000003 RSI: 0000000000000003 RDI: 0000000000000046
[   11.209512] RBP: ffff88013f403fe8 R08: 0000000000000001 R09: 0000000000000001
[   11.209512] R10: 0000000000000000 R11: ffffffff82c98b38 R12: 0000000000000000
[   11.209512] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[   11.209512] FS:  0000000000000000(0000) GS:ffff88013f400000(0000) knlGS:0000000000000000
[   11.209512] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   11.209512] CR2: 0000000000000000 CR3: 0000000002c57001 CR4: 00000000001606f0
[   11.209512] Call Trace:
[   11.209512]  <IRQ>
[   11.209512]  irq_enter+0xa/0x60
[   11.209512]  scheduler_ipi+0x4b/0x8a
[   11.209512]  reschedule_interrupt+0xf/0x20
[   11.209512]  </IRQ>
[   11.209512] RIP: 0010:arch_local_irq_restore+0x2/0x8
[   11.209512] Code: 15 48 c7 c6 19 8c 8c 82 48 c7 c7 ca 58 8b 82 e8 da 0b fc ff 0f 0b 48 c7 43 58 00 00 00 00 5b c3 9c 58 0f 1f 44 00 00 c3 57 9d <0f> 1f 44 00 00 c3 e8 eb ff ff ff 48 89 c2 fa 66 0f 1f 44 00 00 48 
[   11.209512] RSP: 0000:ffffc900000cbe60 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff02
[   11.209512] RAX: ffff88013ead8100 RBX: ffff88013ea0aa80 RCX: 0000000000000000
[   11.209512] RDX: 0000000000000001 RSI: ffffffff83e00190 RDI: 0000000000000246
[   11.209512] RBP: ffffc900000cbed0 R08: ffffffff83e00190 R09: ffffffff8323b3ec
[   11.209512] R10: ffffc900000cbdf8 R11: 0000000000000002 R12: ffff88013f4217c0
[   11.209512] R13: ffff88013f424600 R14: 0000000000000000 R15: 0000000000000000
[   11.209512]  process_one_work+0x1ff/0x4a9
[   11.209512]  ? process_one_work+0x199/0x4a9
[   11.209512]  ? process_scheduled_works+0x2c/0x2c
[   11.209512]  worker_thread+0x1b2/0x261
[   11.209512]  ? process_scheduled_works+0x2c/0x2c
[   11.209512]  kthread+0xf5/0xfa
[   11.209512]  ? queuing_blocked+0x32/0x32
[   11.209512]  ret_from_fork+0x3a/0x50
[   11.209512] irq event stamp: 71539
[   11.209512] hardirqs last  enabled at (71539): [<0000000000000000>]           (null)
[   11.209512] hardirqs last disabled at (71538): [<0000000000000000>]           (null)
[   11.209512] softirqs last  enabled at (71496): [<ffffffff8220030d>] __do_softirq+0x30d/0x38f
[   11.209512] softirqs last disabled at (71489): [<ffffffff810daae3>] irq_exit+0x63/0xd4
[   11.209512] _warn_unseeded_randomness: 1 callbacks suppressed
[   11.209512] random: get_random_bytes called from init_oops_id+0x22/0x31 with crng_init=0
[   11.209512] ---[ end trace ad4d30e5b1ea3d93 ]---


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

View attachment "config-4.18.0-rc6-00023-gc3bc8fd" of type "text/plain" (122751 bytes)

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

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

View attachment "trinity" of type "text/plain" (6305 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ