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-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <5123040C.4070302@linux.vnet.ibm.com>
Date:	Tue, 19 Feb 2013 12:48:12 +0800
From:	Michael Wang <wangyun@...ux.vnet.ibm.com>
To:	Sasha Levin <sasha.levin@...cle.com>
CC:	Ingo Molnar <mingo@...e.hu>, Thomas Gleixner <tglx@...utronix.de>,
	Peter Zijlstra <peterz@...radead.org>,
	"Paul E. McKenney" <paulmck@...ux.vnet.ibm.com>,
	Dave Jones <davej@...hat.com>,
	"linux-kernel@...r.kernel.org" <linux-kernel@...r.kernel.org>
Subject: Re: sched: circular dependency between sched_domains_mutex and oom_notify_list

On 02/17/2013 01:42 PM, Sasha Levin wrote:
> Hi all,
> 
> I was fuzzing with trinity inside a KVM tools guest, with today's -next kernel
> when I've hit the following spew.
> 
> I suspect it's the result of adding the new rcu_oom_notify, but that happened
> about half a year ago so I'm not sure why this showed up only now.

Hi, Sasha

This is a rarely one, isn't it? require 2 conditions:
1. system is oom.
2. rebooting.

The possible dead lock related to oom_notify_list I suppose is:

	CONTEXT A			CONTEXT B

1	oom				reboot

2	LOCK oom_notify_list		cpu_down()

3	rcu_oom_notify()		LOCK cpu_hotplug.lock

4	get_online_cpus()		partition_sched_domains()

5	LOCK cpu_hotplug.lock		__sdt_alloc()		

6					oom

7					LOCK oom_notify_list

	DEAD LOCK

So rcu_oom_notify() trying to lock cpu_hotplug.lock with oom_notify_list
locked, and __sdt_alloc() trying to lock oom_notify_list with
cpu_hotplug.lock locked, a circular locking case.

But I'm not sure why the log show the "sched_domains_mutex" as a target,
so is your system really dead lock or it's just a fake report?

Regards,
Michael Wang

> 
> [ 1039.634183] ======================================================
> [ 1039.635717] [ INFO: possible circular locking dependency detected ]
> [ 1039.637255] 3.8.0-rc7-next-20130215-sasha-00003-gea816fa #286 Tainted: G        W
> [ 1039.639104] -------------------------------------------------------
> [ 1039.640579] init/1 is trying to acquire lock:
> [ 1039.641224]  ((oom_notify_list).rwsem){.+.+..}, at: [<ffffffff81141c8f>] __blocking_notifier_call_chain+0x7f/0xc0
> [ 1039.641224]
> [ 1039.641224] but task is already holding lock:
> [ 1039.641224]  (sched_domains_mutex){+.+.+.}, at: [<ffffffff811522d8>] partition_sched_domains+0x28/0x3f0
> [ 1039.641224]
> [ 1039.641224] which lock already depends on the new lock.
> [ 1039.641224]
> [ 1039.641224]
> [ 1039.641224] the existing dependency chain (in reverse order) is:
> [ 1039.641224]
> -> #2 (sched_domains_mutex){+.+.+.}:
> [ 1039.641224]        [<ffffffff8118013a>] check_prevs_add+0xba/0x1a0
> [ 1039.641224]        [<ffffffff811808c0>] validate_chain.isra.21+0x6a0/0x7b0
> [ 1039.641224]        [<ffffffff81183b43>] __lock_acquire+0xa13/0xb00
> [ 1039.641224]        [<ffffffff8118451a>] lock_acquire+0x1ca/0x270
> [ 1039.641224]        [<ffffffff83d8a19a>] __mutex_lock_common+0x5a/0x560
> [ 1039.641224]        [<ffffffff83d8a7cf>] mutex_lock_nested+0x3f/0x50
> [ 1039.641224]        [<ffffffff811522d8>] partition_sched_domains+0x28/0x3f0
> [ 1039.641224]        [<ffffffff8115274b>] cpuset_cpu_inactive+0x3b/0x50
> [ 1039.641224]        [<ffffffff83d9174e>] notifier_call_chain+0xee/0x130
> [ 1039.641224]        [<ffffffff81141b09>] __raw_notifier_call_chain+0x9/0x10
> [ 1039.641224]        [<ffffffff8110dd1b>] __cpu_notify+0x1b/0x30
> [ 1039.641224]        [<ffffffff83ce34ef>] _cpu_down+0xaf/0x350
> [ 1039.641224]        [<ffffffff8110e164>] disable_nonboot_cpus+0x84/0x1c0
> [ 1039.641224]        [<ffffffff811288f6>] kernel_restart+0x16/0x60
> [ 1039.641224]        [<ffffffff81128ab1>] sys_reboot+0x161/0x2b0
> [ 1039.641224]        [<ffffffff83d96198>] tracesys+0xe1/0xe6
> [ 1039.641224]
> -> #1 (cpu_hotplug.lock){+.+.+.}:
> [ 1039.641224]        [<ffffffff8118013a>] check_prevs_add+0xba/0x1a0
> [ 1039.641224]        [<ffffffff811808c0>] validate_chain.isra.21+0x6a0/0x7b0
> [ 1039.641224]        [<ffffffff81183b43>] __lock_acquire+0xa13/0xb00
> [ 1039.641224]        [<ffffffff8118451a>] lock_acquire+0x1ca/0x270
> [ 1039.641224]        [<ffffffff83d8a19a>] __mutex_lock_common+0x5a/0x560
> [ 1039.641224]        [<ffffffff83d8a7cf>] mutex_lock_nested+0x3f/0x50
> [ 1039.641224]        [<ffffffff8110de77>] get_online_cpus+0x37/0x50
> [ 1039.641224]        [<ffffffff811d01b4>] rcu_oom_notify+0x94/0x150
> [ 1039.641224]        [<ffffffff83d9174e>] notifier_call_chain+0xee/0x130
> [ 1039.641224]        [<ffffffff81141ca8>] __blocking_notifier_call_chain+0x98/0xc0
> [ 1039.641224]        [<ffffffff81141ce1>] blocking_notifier_call_chain+0x11/0x20
> [ 1039.641224]        [<ffffffff81212155>] out_of_memory+0x45/0x1f0
> [ 1039.641224]        [<ffffffff812184dd>] __alloc_pages_nodemask+0x83d/0xbf0
> [ 1039.641224]        [<ffffffff8125d6ac>] alloc_pages_vma+0xfc/0x150
> [ 1039.641224]        [<ffffffff812509f0>] read_swap_cache_async+0x90/0x220
> [ 1039.641224]        [<ffffffff81250c1e>] swapin_readahead+0x9e/0xf0
> [ 1039.641224]        [<ffffffff8123af57>] do_swap_page.isra.41+0x107/0x5a0
> [ 1039.641224]        [<ffffffff8123d056>] handle_pte_fault+0x126/0x200
> [ 1039.641224]        [<ffffffff8123e4a7>] handle_mm_fault+0x397/0x3e0
> [ 1039.641224]        [<ffffffff8123e9d8>] __get_user_pages+0x418/0x5f0
> [ 1039.641224]        [<ffffffff81240563>] __mlock_vma_pages_range+0xb3/0xc0
> [ 1039.641224]        [<ffffffff81240a74>] __mm_populate+0xf4/0x170
> [ 1039.641224]        [<ffffffff81240e10>] sys_mlockall+0x160/0x1a0
> [ 1039.641224]        [<ffffffff83d96198>] tracesys+0xe1/0xe6
> [ 1039.641224]
> -> #0 ((oom_notify_list).rwsem){.+.+..}:
> [ 1039.641224]        [<ffffffff8117fb55>] check_prev_add+0x115/0x640
> [ 1039.641224]        [<ffffffff8118013a>] check_prevs_add+0xba/0x1a0
> [ 1039.641224]        [<ffffffff811808c0>] validate_chain.isra.21+0x6a0/0x7b0
> [ 1039.641224]        [<ffffffff81183b43>] __lock_acquire+0xa13/0xb00
> [ 1039.641224]        [<ffffffff8118451a>] lock_acquire+0x1ca/0x270
> [ 1039.641224]        [<ffffffff83d8adb7>] down_read+0x47/0x8e
> [ 1039.641224]        [<ffffffff81141c8f>] __blocking_notifier_call_chain+0x7f/0xc0
> [ 1039.641224]        [<ffffffff81141ce1>] blocking_notifier_call_chain+0x11/0x20
> [ 1039.641224]        [<ffffffff81212155>] out_of_memory+0x45/0x1f0
> [ 1039.641224]        [<ffffffff812184dd>] __alloc_pages_nodemask+0x83d/0xbf0
> [ 1039.641224]        [<ffffffff8126629a>] allocate_slab+0x13a/0x1f0
> [ 1039.641224]        [<ffffffff8126637b>] new_slab+0x2b/0x1b0
> [ 1039.641224]        [<ffffffff83d030e1>] __slab_alloc.isra.34+0x1c5/0x31f
> [ 1039.641224]        [<ffffffff81268e14>] kmem_cache_alloc_node_trace+0x114/0x390
> [ 1039.641224]        [<ffffffff8114b567>] __sdt_alloc+0x137/0x1f0
> [ 1039.641224]        [<ffffffff81151d2c>] build_sched_domains+0x2c/0x4e0
> [ 1039.641224]        [<ffffffff81152603>] partition_sched_domains+0x353/0x3f0
> [ 1039.641224]        [<ffffffff8115274b>] cpuset_cpu_inactive+0x3b/0x50
> [ 1039.641224]        [<ffffffff83d9174e>] notifier_call_chain+0xee/0x130
> [ 1039.641224]        [<ffffffff81141b09>] __raw_notifier_call_chain+0x9/0x10
> [ 1039.641224]        [<ffffffff8110dd1b>] __cpu_notify+0x1b/0x30
> [ 1039.641224]        [<ffffffff83ce34ef>] _cpu_down+0xaf/0x350
> [ 1039.641224]        [<ffffffff8110e164>] disable_nonboot_cpus+0x84/0x1c0
> [ 1039.641224]        [<ffffffff811288f6>] kernel_restart+0x16/0x60
> [ 1039.641224]        [<ffffffff81128ab1>] sys_reboot+0x161/0x2b0
> [ 1039.641224]        [<ffffffff83d96198>] tracesys+0xe1/0xe6
> [ 1039.641224]
> [ 1039.641224] other info that might help us debug this:
> [ 1039.641224]
> [ 1039.641224] Chain exists of:
>   (oom_notify_list).rwsem --> cpu_hotplug.lock --> sched_domains_mutex
> 
> [ 1039.641224]  Possible unsafe locking scenario:
> [ 1039.641224]
> [ 1039.641224]        CPU0                    CPU1
> [ 1039.641224]        ----                    ----
> [ 1039.641224]   lock(sched_domains_mutex);
> [ 1039.641224]                                lock(cpu_hotplug.lock);
> [ 1039.641224]                                lock(sched_domains_mutex);
> [ 1039.641224]   lock((oom_notify_list).rwsem);
> [ 1039.641224]
> [ 1039.641224]  *** DEADLOCK ***
> [ 1039.641224]
> [ 1039.641224] 4 locks held by init/1:
> [ 1039.641224]  #0:  (reboot_mutex){+.+.+.}, at: [<ffffffff81128a2e>] sys_reboot+0xde/0x2b0
> [ 1039.641224]  #1:  (cpu_add_remove_lock){+.+.+.}, at: [<ffffffff8110dea2>] cpu_maps_update_begin+0x12/0x20
> [ 1039.641224]  #2:  (cpu_hotplug.lock){+.+.+.}, at: [<ffffffff8110dd87>] cpu_hotplug_begin+0x27/0x60
> [ 1039.641224]  #3:  (sched_domains_mutex){+.+.+.}, at: [<ffffffff811522d8>] partition_sched_domains+0x28/0x3f0
> [ 1039.641224]
> [ 1039.641224] stack backtrace:
> [ 1039.641224] Pid: 1, comm: init Tainted: G        W    3.8.0-rc7-next-20130215-sasha-00003-gea816fa #286
> [ 1039.641224] Call Trace:
> [ 1039.641224]  [<ffffffff83cff50f>] print_circular_bug+0xd3/0xe4
> [ 1039.641224]  [<ffffffff8117fb55>] check_prev_add+0x115/0x640
> [ 1039.641224]  [<ffffffff8118013a>] check_prevs_add+0xba/0x1a0
> [ 1039.641224]  [<ffffffff81074ef5>] ? sched_clock+0x15/0x20
> [ 1039.641224]  [<ffffffff811808c0>] validate_chain.isra.21+0x6a0/0x7b0
> [ 1039.641224]  [<ffffffff81183b43>] __lock_acquire+0xa13/0xb00
> [ 1039.641224]  [<ffffffff81074ef5>] ? sched_clock+0x15/0x20
> [ 1039.641224]  [<ffffffff810a1258>] ? kvm_clock_read+0x38/0x70
> [ 1039.641224]  [<ffffffff8118451a>] lock_acquire+0x1ca/0x270
> [ 1039.641224]  [<ffffffff81141c8f>] ? __blocking_notifier_call_chain+0x7f/0xc0
> [ 1039.641224]  [<ffffffff83d8adb7>] down_read+0x47/0x8e
> [ 1039.641224]  [<ffffffff81141c8f>] ? __blocking_notifier_call_chain+0x7f/0xc0
> [ 1039.641224]  [<ffffffff81141c8f>] __blocking_notifier_call_chain+0x7f/0xc0
> [ 1039.641224]  [<ffffffff81141ce1>] blocking_notifier_call_chain+0x11/0x20
> [ 1039.641224]  [<ffffffff81212155>] out_of_memory+0x45/0x1f0
> [ 1039.641224]  [<ffffffff812184dd>] __alloc_pages_nodemask+0x83d/0xbf0
> [ 1039.641224]  [<ffffffff8126629a>] allocate_slab+0x13a/0x1f0
> [ 1039.641224]  [<ffffffff8126637b>] new_slab+0x2b/0x1b0
> [ 1039.641224]  [<ffffffff83d030e1>] __slab_alloc.isra.34+0x1c5/0x31f
> [ 1039.641224]  [<ffffffff81182492>] ? __lock_is_held+0x52/0x80
> [ 1039.641224]  [<ffffffff8114b567>] ? __sdt_alloc+0x137/0x1f0
> [ 1039.641224]  [<ffffffff81268e14>] kmem_cache_alloc_node_trace+0x114/0x390
> [ 1039.641224]  [<ffffffff8123349b>] ? pcpu_alloc+0x32b/0x3e0
> [ 1039.641224]  [<ffffffff8114b52b>] ? __sdt_alloc+0xfb/0x1f0
> [ 1039.641224]  [<ffffffff8114b567>] ? __sdt_alloc+0x137/0x1f0
> [ 1039.641224]  [<ffffffff8114b567>] __sdt_alloc+0x137/0x1f0
> [ 1039.641224]  [<ffffffff811524d0>] ? partition_sched_domains+0x220/0x3f0
> [ 1039.641224]  [<ffffffff81151d2c>] build_sched_domains+0x2c/0x4e0
> [ 1039.641224]  [<ffffffff81152603>] partition_sched_domains+0x353/0x3f0
> [ 1039.641224]  [<ffffffff81152397>] ? partition_sched_domains+0xe7/0x3f0
> [ 1039.641224]  [<ffffffff8115274b>] cpuset_cpu_inactive+0x3b/0x50
> [ 1039.641224]  [<ffffffff83d9174e>] notifier_call_chain+0xee/0x130
> [ 1039.641224]  [<ffffffff81141b09>] __raw_notifier_call_chain+0x9/0x10
> [ 1039.641224]  [<ffffffff8110dd1b>] __cpu_notify+0x1b/0x30
> [ 1039.641224]  [<ffffffff83ce34ef>] _cpu_down+0xaf/0x350
> [ 1039.641224]  [<ffffffff83cfd6b8>] ? printk+0x5c/0x5e
> [ 1039.641224]  [<ffffffff8110e164>] disable_nonboot_cpus+0x84/0x1c0
> [ 1039.641224]  [<ffffffff811288f6>] kernel_restart+0x16/0x60
> [ 1039.641224]  [<ffffffff81128ab1>] sys_reboot+0x161/0x2b0
> [ 1039.641224]  [<ffffffff811d5dc4>] ? rcu_eqs_exit_common+0x64/0x340
> [ 1039.641224]  [<ffffffff811d7146>] ? rcu_eqs_enter_common+0x306/0x3a0
> [ 1039.641224]  [<ffffffff8120cac5>] ? user_exit+0xa5/0xd0
> [ 1039.641224]  [<ffffffff811813e8>] ? trace_hardirqs_on_caller+0x128/0x160
> [ 1039.641224]  [<ffffffff8118142d>] ? trace_hardirqs_on+0xd/0x10
> [ 1039.641224]  [<ffffffff8107ad34>] ? syscall_trace_enter+0x24/0x2e0
> [ 1039.641224]  [<ffffffff811813e8>] ? trace_hardirqs_on_caller+0x128/0x160
> [ 1039.641224]  [<ffffffff83d96198>] tracesys+0xe1/0xe6
> 
> 
> Thanks,
> Sasha
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@...r.kernel.org
> More majordomo info at  http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at  http://www.tux.org/lkml/
> 

--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@...r.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ