From: Kirill Tkhai <ktkhai@odin.com>
To: kernel test robot <ying.huang@linux.intel.com>
Cc: <lkp@01.org>, LKML <linux-kernel@vger.kernel.org>,
0day robot <fengguang.wu@intel.com>
Subject: Re: [lkp] [sched/fair] 482eaa50ff: INFO: suspicious RCU usage. ]
Date: Tue, 29 Sep 2015 11:53:02 +0300 [thread overview]
Message-ID: <560A516E.5090809@odin.com> (raw)
In-Reply-To: <8737xxoejv.fsf@yhuang-dev.intel.com>
On 29.09.2015 10:44, kernel test robot wrote:
> FYI, we noticed the below changes on
>
> git://internal_merge_and_test_tree revert-482eaa50ff81046e1e9f95af94176953d0743ec9-482eaa50ff81046e1e9f95af94176953d0743ec9
> commit 482eaa50ff81046e1e9f95af94176953d0743ec9 ("sched/fair: Skip wake_affine() for core siblings")
Yeah, thanks.
> +-------------------------------------------------------+----------+------------+
> | | v4.3-rc3 | 482eaa50ff |
> +-------------------------------------------------------+----------+------------+
> | boot_successes | 54 | 0 |
> | boot_failures | 10 | 13 |
> | IP-Config:Auto-configuration_of_network_failed | 10 | |
> | INFO:suspicious_RCU_usage | 0 | 13 |
> | BUG:scheduling_while_atomic | 0 | 13 |
> | INFO:lockdep_is_turned_off | 0 | 13 |
> | kernel_BUG_at_kernel/sched/core.c | 0 | 13 |
> | invalid_opcode:#[##]SMP_DEBUG_PAGEALLOC | 0 | 13 |
> | EIP_is_at__sched_setscheduler | 0 | 13 |
> | Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 13 |
> | backtrace:spawn_ksoftirqd | 0 | 13 |
> | backtrace:kernel_init_freeable | 0 | 13 |
> | backtrace:schedule | 0 | 13 |
> +-------------------------------------------------------+----------+------------+
>
>
> [ 0.074005] Failed to access perfctr msr (MSR c2 is 0)
> [ 0.075108]
> [ 0.075427] ===============================
> [ 0.076000] [ INFO: suspicious RCU usage. ]
> [ 0.076000] 4.3.0-rc3-00001-g482eaa5 #282 Not tainted
> [ 0.076000] -------------------------------
> [ 0.076000] kernel/sched/fair.c:4796 suspicious rcu_dereference_check() usage!
> [ 0.076000]
> [ 0.076000] other info that might help us debug this:
> [ 0.076000]
> [ 0.076000]
> [ 0.076000] rcu_scheduler_active = 1, debug_locks = 0
> [ 0.076000] 3 locks held by swapper/0/1:
> [ 0.076000] #0: (cpu_hotplug.lock){.+.+.+}, at: [<c104408a>] get_online_cpus+0x27/0x62
> [ 0.076000] #1: (smpboot_threads_lock){+.+.+.}, at: [<c105ae50>] smpboot_register_percpu_thread_cpumask+0x24/0xa1
> [ 0.076000] #2: (&p->pi_lock){......}, at: [<c105e0e8>] try_to_wake_up+0x1d/0x19c
> [ 0.076000]
> [ 0.076000] stack backtrace:
> [ 0.076000] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.3.0-rc3-00001-g482eaa5 #282
> [ 0.076000] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
> [ 0.076000] 00000000 00000000 d3081da8 c1219245 00000001 d3081dc4 c1070a55 c1aeb4d8
> [ 0.076000] d3078000 00000000 00000000 00000000 d3081e1c c106444c 00000001 00000010
> [ 0.076000] 480d0069 00000000 d307f198 00000046 00000046 d3081e18 c107064c 00000002
> [ 0.076000] Call Trace:
> [ 0.076000] [<c1219245>] dump_stack+0x48/0x60
> [ 0.076000] [<c1070a55>] lockdep_rcu_suspicious+0xd4/0xdd
> [ 0.076000] [<c106444c>] select_task_rq_fair+0x2d8/0x64d
> [ 0.076000] [<c107064c>] ? lock_acquire+0x72/0x7d
> [ 0.076000] [<c106d2e8>] ? __lock_is_held+0x2e/0x44
> [ 0.076000] [<c105d71f>] select_task_rq+0x3c/0x8f
> [ 0.076000] [<c105e19f>] try_to_wake_up+0xd4/0x19c
> [ 0.076000] [<c105e290>] wake_up_process+0x29/0x2c
> [ 0.076000] [<c105848c>] kthread_create_on_node+0x95/0x104
> [ 0.076000] [<c10585a6>] kthread_create_on_cpu+0x14/0x44
> [ 0.076000] [<c105a9f3>] ? cpumask_next+0x26/0x26
> [ 0.076000] [<c105acbb>] __smpboot_create_thread+0x4e/0xb0
> [ 0.076000] [<c105ae70>] smpboot_register_percpu_thread_cpumask+0x44/0xa1
> [ 0.076000] [<c1d4cc3b>] ? cpu_hotplug_pm_sync_init+0x11/0x11
> [ 0.076000] [<c1d4cc58>] spawn_ksoftirqd+0x1d/0x27
> [ 0.076000] [<c1d39bcc>] do_one_initcall+0xd0/0x14e
> [ 0.076000] [<c1076213>] ? vprintk_default+0x12/0x14
> [ 0.076000] [<c10a6426>] ? printk+0x12/0x14
> [ 0.076000] [<c100dbba>] ? print_cpu_info+0x8e/0xab
> [ 0.076000] [<c100dbd0>] ? print_cpu_info+0xa4/0xab
> [ 0.076000] [<c1d47377>] ? native_smp_prepare_cpus+0x223/0x25e
> [ 0.076000] [<c1d39ca7>] kernel_init_freeable+0x5d/0x172
> [ 0.076000] [<c17aaaf8>] kernel_init+0x8/0xb5
> [ 0.076000] [<c17b29c1>] ret_from_kernel_thread+0x21/0x30
> [ 0.076000] [<c17aaaf0>] ? rest_init+0x116/0x116
> [ 0.076008] BUG: scheduling while atomic: swapper/0/1/0x00000000
> [ 0.077003] INFO: lockdep is turned off.
> [ 0.078006] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.3.0-rc3-00001-g482eaa5 #282
> [ 0.079004] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
> [ 0.080004] 00000000 00000000 d3081db0 c1219245 d3078000 d3081dbc c105c084 00000000
> [ 0.082003] d3081de0 c17aedc2 00000000 d307f188 d3081e84 d3078000 d3082000 d3081e70
> [ 0.083805] d3078000 d3081dec c17af235 7fffffff d3081e24 c17b1d4c 00000000 00000000
> [ 0.085648] Call Trace:
> [ 0.086008] [<c1219245>] dump_stack+0x48/0x60
> [ 0.087008] [<c105c084>] __schedule_bug+0x52/0x63
> [ 0.088007] [<c17aedc2>] __schedule+0x5a/0x436
> [ 0.089006] [<c17af235>] schedule+0x64/0x78
> [ 0.090007] [<c17b1d4c>] schedule_timeout+0x15/0xb1
> [ 0.091006] [<c17af938>] ? __wait_for_common+0xd4/0x105
> [ 0.092007] [<c106ea1e>] ? trace_hardirqs_on+0xb/0xd
> [ 0.093006] [<c17b2357>] ? _raw_spin_unlock_irq+0x27/0x31
> [ 0.094006] [<c17af93f>] __wait_for_common+0xdb/0x105
> [ 0.095007] [<c17b1d37>] ? console_conditional_schedule+0x24/0x24
> [ 0.096007] [<c105e974>] ? get_parent_ip+0x31/0x31
> [ 0.097007] [<c17afa10>] wait_for_completion_killable+0x17/0x2c
> [ 0.098007] [<c1058493>] kthread_create_on_node+0x9c/0x104
> [ 0.099006] [<c10585a6>] kthread_create_on_cpu+0x14/0x44
> [ 0.100005] [<c105a9f3>] ? cpumask_next+0x26/0x26
> [ 0.101005] [<c105acbb>] __smpboot_create_thread+0x4e/0xb0
> [ 0.102005] [<c105ae70>] smpboot_register_percpu_thread_cpumask+0x44/0xa1
> [ 0.103007] [<c1d4cc3b>] ? cpu_hotplug_pm_sync_init+0x11/0x11
> [ 0.104005] [<c1d4cc58>] spawn_ksoftirqd+0x1d/0x27
> [ 0.105006] [<c1d39bcc>] do_one_initcall+0xd0/0x14e
> [ 0.106006] [<c1076213>] ? vprintk_default+0x12/0x14
> [ 0.107010] [<c10a6426>] ? printk+0x12/0x14
> [ 0.107916] [<c100dbba>] ? print_cpu_info+0x8e/0xab
> [ 0.108006] [<c100dbd0>] ? print_cpu_info+0xa4/0xab
> [ 0.109007] [<c1d47377>] ? native_smp_prepare_cpus+0x223/0x25e
> [ 0.110006] [<c1d39ca7>] kernel_init_freeable+0x5d/0x172
> [ 0.111008] [<c17aaaf8>] kernel_init+0x8/0xb5
> [ 0.112007] [<c17b29c1>] ret_from_kernel_thread+0x21/0x30
> [ 0.113006] [<c17aaaf0>] ? rest_init+0x116/0x116
> [ 0.114092] BUG: scheduling while atomic: kthreadd/3/0x00000000
> [ 0.115003] INFO: lockdep is turned off.
> [ 0.116006] CPU: 0 PID: 3 Comm: kthreadd Tainted: G W 4.3.0-rc3-00001-g482eaa5 #282
> [ 0.117005] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
> [ 0.118005] 00000000 00000000 d3093ef4 c1219245 d3078dc0 d3093f00 c105c084 00000000
> [ 0.120293] d3093f24 c17aedc2 00000282 d3093f1c c17b2325 d3078dc0 d3094000 d3058c00
> [ 0.122072] c105a9f3 d3093f30 c17af235 d3059dd0 d3093fac c105830a d3093f74 00000000
> [ 0.124069] Call Trace:
> [ 0.124610] [<c1219245>] dump_stack+0x48/0x60
> [ 0.125007] [<c105c084>] __schedule_bug+0x52/0x63
> [ 0.126008] [<c17aedc2>] __schedule+0x5a/0x436
> [ 0.127007] [<c17b2325>] ? _raw_spin_unlock_irqrestore+0x3f/0x4a
> [ 0.128006] [<c105a9f3>] ? cpumask_next+0x26/0x26
> [ 0.129006] [<c17af235>] schedule+0x64/0x78
> [ 0.130006] [<c105830a>] kthread+0x87/0xa5
> [ 0.131007] [<c107064c>] ? lock_acquire+0x72/0x7d
> [ 0.132007] [<c17b29c1>] ret_from_kernel_thread+0x21/0x30
> [ 0.133007] [<c1058283>] ? __kthread_parkme+0x83/0x83
> [ 0.134020] ------------[ cut here ]------------
> [ 0.135000] kernel BUG at kernel/sched/core.c:3740!
> [ 0.135000] invalid opcode: 0000 [#1] SMP DEBUG_PAGEALLOC
> [ 0.135000] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G W 4.3.0-rc3-00001-g482eaa5 #282
> [ 0.135000] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.7.5-20140531_083030-gandalf 04/01/2014
> [ 0.135000] task: d3078000 ti: d3080000 task.ti: d3080000
> [ 0.135000] EIP: 0060:[<c105ec63>] EFLAGS: 00010206 CPU: 0
> [ 0.135000] EIP is at __sched_setscheduler+0x39/0x6b8
> [ 0.135000] EAX: 7fffffff EBX: 00000000 ECX: 00000000 EDX: 00000063
> [ 0.135000] ESI: d3078dc0 EDI: d3081e18 EBP: d3081e0c ESP: d3081dc4
> [ 0.135000] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068
> [ 0.135000] CR0: 8005003b CR2: ffffffff CR3: 01dd3000 CR4: 000006b0
> [ 0.135000] Stack:
> [ 0.135000] 00000000 00000000 d3081e84 00000086 d3081ddc 00000063 d3081e18 c1070700
> [ 0.135000] 00000001 00000001 00010000 d30790ac 00000030 00000000 00000086 d3078dc0
> [ 0.135000] c17bcf28 d3081e48 d3081e54 c105f344 00000000 00000000 00000000 00000000
> [ 0.135000] Call Trace:
> [ 0.135000] [<c1070700>] ? lock_release+0xa9/0x29a
> [ 0.135000] [<c105f344>] _sched_setscheduler+0x62/0x6a
> [ 0.135000] [<c105f533>] sched_setscheduler_nocheck+0xa/0xc
> [ 0.135000] [<c10584dd>] kthread_create_on_node+0xe6/0x104
> [ 0.135000] [<c10585a6>] kthread_create_on_cpu+0x14/0x44
> [ 0.135000] [<c105a9f3>] ? cpumask_next+0x26/0x26
> [ 0.135000] [<c105acbb>] __smpboot_create_thread+0x4e/0xb0
> [ 0.135000] [<c105ae70>] smpboot_register_percpu_thread_cpumask+0x44/0xa1
> [ 0.135000] [<c1d4cc3b>] ? cpu_hotplug_pm_sync_init+0x11/0x11
> [ 0.135000] [<c1d4cc58>] spawn_ksoftirqd+0x1d/0x27
> [ 0.135000] [<c1d39bcc>] do_one_initcall+0xd0/0x14e
> [ 0.135000] [<c1076213>] ? vprintk_default+0x12/0x14
> [ 0.135000] [<c10a6426>] ? printk+0x12/0x14
> [ 0.135000] [<c100dbba>] ? print_cpu_info+0x8e/0xab
> [ 0.135000] [<c100dbd0>] ? print_cpu_info+0xa4/0xab
> [ 0.135000] [<c1d47377>] ? native_smp_prepare_cpus+0x223/0x25e
> [ 0.135000] [<c1d39ca7>] kernel_init_freeable+0x5d/0x172
> [ 0.135000] [<c17aaaf8>] kernel_init+0x8/0xb5
> [ 0.135000] [<c17b29c1>] ret_from_kernel_thread+0x21/0x30
> [ 0.135000] [<c17aaaf0>] ? rest_init+0x116/0x116
> [ 0.135000] Code: 42 04 88 4d d4 c7 45 cc ff ff ff ff 83 f8 06 74 0b ba 63 00 00 00 2b 57 14 89 55 cc 89 c3 64 a1 04 28 dc c1 a9 00 ff 1f 00 74 3d <0f> 0b 8b 8e 3c 01 00 00 39 cb 0f 84 27 02 00 00 80 7d d4 00 0f
> [ 0.135000] EIP: [<c105ec63>] __sched_setscheduler+0x39/0x6b8 SS:ESP 0068:d3081dc4
> [ 0.135012] ---[ end trace d248a7baa3fff262 ]---
> [ 0.136006] Kernel panic - not syncing: Fatal exception in interrupt
>
>
>
>
>
> Thanks,
> Ying Huang
>
next prev parent reply other threads:[~2015-09-29 8:53 UTC|newest]
Thread overview: 5+ messages / expand[flat|nested] mbox.gz Atom feed top
2015-09-29 7:44 [sched/fair] 482eaa50ff: INFO: suspicious RCU usage. ] kernel test robot
2015-09-29 7:44 ` [lkp] " kernel test robot
2015-09-29 8:53 ` Kirill Tkhai [this message]
2015-09-30 22:43 ` [sched/fair] swapper/0/1 is trying to release lock (rcu_read_lockrcu_read_lock) at: Fengguang Wu
2015-09-30 22:43 ` Fengguang Wu
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=560A516E.5090809@odin.com \
--to=ktkhai@odin.com \
--cc=fengguang.wu@intel.com \
--cc=linux-kernel@vger.kernel.org \
--cc=lkp@01.org \
--cc=ying.huang@linux.intel.com \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.