| 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
| ||
|
Message-ID: <20170417025054.GR16549@yexl-desktop>
Date: Mon, 17 Apr 2017 10:50:54 +0800
From: kernel test robot <xiaolong.ye@...el.com>
To: Thomas Gleixner <tglx@...utronix.de>
Cc: LKML <linux-kernel@...r.kernel.org>,
Ingo Molnar <mingo@...nel.org>,
"H. Peter Anvin" <hpa@...or.com>,
Thomas Gleixner <tglx@...utronix.de>, tipbuild@...or.com,
lkp@...org
Subject: [lkp-robot] [cpu/hotplug] 94380da276:
INFO:possible_recursive_locking_detected
FYI, we noticed the following commit:
commit: 94380da2765a391335c2326ba327e835c2e7aa03 ("cpu/hotplug: Convert hotplug locking to percpu rwsem")
https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git WIP.hotplug
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 IvyBridge -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+------------------------------------------+------------+------------+
| | d632ccfe1c | 94380da276 |
+------------------------------------------+------------+------------+
| boot_successes | 0 | 4 |
| boot_failures | 0 | 4 |
| INFO:possible_recursive_locking_detected | 0 | 4 |
| calltrace:SyS_perf_event_open | 0 | 4 |
+------------------------------------------+------------+------------+
[ 23.381603] [ INFO: possible recursive locking detected ]
[ 23.383344] 4.11.0-rc6-00236-g94380da #32 Not tainted
[ 23.385029] ---------------------------------------------
[ 23.386830] trinity-main/2266 is trying to acquire lock:
[ 23.388554] (cpu_hotplug_lock.rw_sem){.+.+.+}, at: [<ffffffff811992fa>] perf_swevent_init+0x75/0x286
[ 23.391640]
[ 23.391640] but task is already holding lock:
[ 23.394084] (cpu_hotplug_lock.rw_sem){.+.+.+}, at: [<ffffffff811a30db>] SyS_perf_event_open+0x547/0xe3c
[ 23.397273]
[ 23.397273] other info that might help us debug this:
[ 23.399855] Possible unsafe locking scenario:
[ 23.399855]
[ 23.402314] CPU0
[ 23.403507] ----
[ 23.405813] lock(cpu_hotplug_lock.rw_sem);
[ 23.407449] lock(cpu_hotplug_lock.rw_sem);
[ 23.409117]
[ 23.409117] *** DEADLOCK ***
[ 23.409117]
[ 23.412453] May be due to missing lock nesting notation
[ 23.412453]
[ 23.415292] 3 locks held by trinity-main/2266:
[ 23.416986] #0: (cpu_hotplug_lock.rw_sem){.+.+.+}, at: [<ffffffff811a30db>] SyS_perf_event_open+0x547/0xe3c
[ 23.433473] #1: (&sig->cred_guard_mutex){+.+.+.}, at: [<ffffffff811a3146>] SyS_perf_event_open+0x5b2/0xe3c
[ 23.436931] #2: (&pmus_srcu){......}, at: [<ffffffff8119ab29>] perf_event_alloc+0x2fc/0x7a1
[ 23.457210]
[ 23.457210] stack backtrace:
[ 23.459813] CPU: 0 PID: 2266 Comm: trinity-main Not tainted 4.11.0-rc6-00236-g94380da #32
[ 23.463175] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 23.481993] Call Trace:
[ 23.483305] dump_stack+0x86/0xc0
[ 23.484930] __lock_acquire+0x9a4/0x1580
[ 23.486552] ? kvm_sched_clock_read+0x9/0x12
[ 23.488380] lock_acquire+0x180/0x21b
[ 23.489918] ? lock_acquire+0x180/0x21b
[ 23.491528] ? perf_swevent_init+0x75/0x286
[ 23.493332] get_online_cpus+0x42/0x80
[ 23.494906] ? perf_swevent_init+0x75/0x286
[ 23.496605] perf_swevent_init+0x75/0x286
[ 23.498260] ? perf_event_alloc+0x346/0x7a1
[ 23.499973] perf_try_init_event+0x46/0x76
[ 23.501662] perf_event_alloc+0x46d/0x7a1
[ 23.503339] SyS_perf_event_open+0x587/0xe3c
[ 23.505078] do_int80_syscall_32+0x66/0x12c
[ 23.506792] entry_INT80_compat+0x38/0x50
[ 23.508468] RIP: 0023:0x8090aa2
[ 23.509962] RSP: 002b:00000000ffd738d8 EFLAGS: 00000282 ORIG_RAX: 0000000000000150
[ 23.513094] RAX: ffffffffffffffda RBX: 0000000008b1e790 RCX: 0000000000000000
[ 23.515432] RDX: 00000000ffffffff RSI: 00000000ffffffff RDI: 0000000000000009
[ 23.517789] RBP: 000000006d656d0c R08: 0000000000000000 R09: 0000000000000000
[ 23.520128] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 23.522463] R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
[ 23.574529] trinity-main uses obsolete (PF_INET,SOCK_PACKET)
[ 23.591467] kernel msg: ebtables bug: please report to author: Wrong len argument
[ 24.396248] VFS: Warning: trinity-c0 using old stat() call. Recompile your binary.
[ 24.812470] VFS: Warning: trinity-c1 using old stat() call. Recompile your binary.
[ 25.016003] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary.
[ 25.298865] VFS: Warning: trinity-c0 using old stat() call. Recompile your binary.
[ 25.641396] VFS: Warning: trinity-c2 using old stat() call. Recompile your binary.
[ 62.647743] rcu-torture: rtc: ffffffff836b9d00 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[ 62.655884] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 62.661435] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 62.664264] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 95.628115] trinity-c1 (3029) used greatest stack depth: 12776 bytes left
[ 124.087732] rcu-torture: rtc: ffffffff836b9d00 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[ 124.093259] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 124.098220] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 124.100963] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 124.103961] ??? Writer stall state RTWS_STUTTER(8) g16575 c16575 f0x2 ->state 0x1
[ 124.107832] rcu_sched: wait state: 1 ->state: 0x1
[ 124.110243] rcu_bh: wait state: 1 ->state: 0x1
[ 124.112572] Dumping ftrace buffer:
[ 124.113953] (ftrace buffer empty)
[ 185.527728] rcu-torture: rtc: ffffffff836b9d00 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[ 185.537727] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 185.544726] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 185.549730] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 185.554738] ??? Writer stall state RTWS_STUTTER(8) g16740 c16740 f0x2 ->state 0x0
[ 185.559754] rcu_sched: wait state: 1 ->state: 0x1
[ 185.564727] rcu_bh: wait state: 1 ->state: 0x1
[ 246.967752] rcu-torture: rtc: ffffffff836b9d00 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[ 246.973174] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 246.977499] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 246.980084] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 246.984216] ??? Writer stall state RTWS_STUTTER(8) g16914 c16914 f0x2 ->state 0x1
[ 246.987555] rcu_sched: wait state: 1 ->state: 0x1
[ 246.991049] rcu_bh: wait state: 1 ->state: 0x1
[ 308.407742] rcu-torture: rtc: ffffffff836b9d00 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 onoff: 0/0:0/0 -1,0:-1,0 0:0 (HZ=1000) barrier: 0/0:0 cbflood: 1
[ 308.414492] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 308.420303] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 308.423144] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 308.426222] ??? Writer stall state RTWS_STUTTER(8) g19059 c19059 f0x2 ->state 0x1
[ 308.430474] rcu_sched: wait state: 1 ->state: 0x1
[ 308.432968] rcu_bh: wait state: 1 ->state: 0x1
[ 315.411616] sysrq: SysRq : Emergency Sync
[ 315.413203] Emergency Sync complete
[ 315.414894] sysrq: SysRq : Resetting
Elapsed time: 320
initrds=(
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
View attachment "config-4.11.0-rc6-00236-g94380da" of type "text/plain" (115979 bytes)
View attachment "job-script" of type "text/plain" (3686 bytes)
Download attachment "dmesg.xz" of type "application/octet-stream" (14964 bytes)
Powered by blists - more mailing lists