[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <87ip2opntp.fsf@nemi.mork.no>
Date: Sun, 12 May 2013 11:08:50 +0200
From: Bjørn Mork <bjorn@...k.no>
To: Dipankar Sarma <dipankar@...ibm.com>,
"Paul E. McKenney" <paulmck@...ux.vnet.ibm.com>
Cc: linux-kernel@...r.kernel.org
Subject: [v3.10-rc1] WARNING: at kernel/rcutree.c:502
Hello,
got the splat below when running powertop on plain v3.10-rc1
(i.e. without my previously mentioned revert patch or any other extra
patches). Config attached.
[ 45.376480] ------------[ cut here ]------------
[ 45.378453] WARNING: at kernel/rcutree.c:502 rcu_eqs_exit_common.isra.48+0x3d/0x125()
[ 45.380423] Modules linked in: msr cpufreq_stats xt_multiport iptable_filter ip_tables rfcomm bnep xt_hl binfmt_misc ip6table_filter ip6_tables x_tables nfsd nfs_acl nfs lockd fscache sunrpc 8021q garp stp llc tun loop fuse cdc_mbim cdc_ncm cdc_wdm usbnet mii snd_hda_codec_conexant arc4 iwldvm iTCO_wdt mac80211 iTCO_vendor_support snd_hda_intel snd_hda_codec snd_hwdep snd_pcm_oss snd_mixer_oss snd_pcm snd_page_alloc thinkpad_acpi nvram snd_seq_midi snd_seq_midi_event snd_rawmidi uvcvideo coretemp videobuf2_vmalloc snd_seq videobuf2_memops videobuf2_core kvm_intel i915 videodev iwlwifi i2c_algo_bit drm_kms_helper kvm snd_seq_device evdev psmouse snd_timer serio_raw cfg80211 lpc_ich btusb drm mfd_core i2c_i801 bluetooth i2c_core snd wmi soundcore battery rfkill ac acpi_cpufreq mperf video processor button ext4 crc16 jbd2 mbcache nbd sg sr_mod sd_mod crc_t10dif cdrom ahci libahci microcode libata scsi_mod thermal thermal_sys ehci_pci uhci_hcd ehci_hcd usbcore e1000e ptp pps_core usb_common
[ 45.380462] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 3.10.0-rc1 #86
[ 45.380462] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.380462] ffffffff8157d888 ffffffff81801e28 ffffffff8137e4e3 ffffffff81801e68
[ 45.380462] ffffffff8103094f ffffffff81801e68 0000000000000000 ffff88023afcd9b0
[ 45.380462] 0000000000000000 0140000000000000 ffff88023bee7780 ffffffff81801e78
[ 45.380462] Call Trace:
[ 45.380462] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.380462] [<ffffffff8103094f>] warn_slowpath_common+0x62/0x7b
[ 45.380462] [<ffffffff8103097d>] warn_slowpath_null+0x15/0x17
[ 45.380462] [<ffffffff810a9006>] rcu_eqs_exit_common.isra.48+0x3d/0x125
[ 45.380462] [<ffffffff81079b49>] ? trace_hardirqs_off_caller+0x37/0xa6
[ 45.380462] [<ffffffff810a9692>] rcu_idle_exit+0x85/0xa8
[ 45.380462] [<ffffffff8107076e>] trace_cpu_idle_rcuidle+0xae/0xff
[ 45.380462] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.380462] [<ffffffff813689e5>] rest_init+0x149/0x150
[ 45.380462] [<ffffffff8136889c>] ? csum_partial_copy_generic+0x16c/0x16c
[ 45.380462] [<ffffffff81a82d34>] start_kernel+0x3f0/0x3fd
[ 45.380462] [<ffffffff81a8274c>] ? repair_env_string+0x5a/0x5a
[ 45.380462] [<ffffffff81a82481>] x86_64_start_reservations+0x2a/0x2c
[ 45.380462] [<ffffffff81a82550>] x86_64_start_kernel+0xcd/0xd1
[ 45.380462] ---[ end trace 99f147d3a7347ae6 ]---
[ 45.380462]
[ 45.380462] ===============================
[ 45.380462] [ INFO: suspicious RCU usage. ]
[ 45.380462] 3.10.0-rc1 #86 Tainted: G W
[ 45.380462] -------------------------------
[ 45.380462] include/trace/events/power.h:35 suspicious rcu_dereference_check() usage!
[ 45.380462]
[ 45.380462] other info that might help us debug this:
[ 45.380462]
[ 45.380462]
[ 45.380462] RCU used illegally from idle CPU!
[ 45.380462] rcu_scheduler_active = 1, debug_locks = 1
[ 45.380462] RCU used illegally from extended quiescent state!
[ 45.380462] no locks held by swapper/0/0.
[ 45.380462]
[ 45.380462] stack backtrace:
[ 45.380462] CPU: 0 PID: 0 Comm: swapper/0 Tainted: G W 3.10.0-rc1 #86
[ 45.380462] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.380462] 0000000000000001 ffffffff81801eb8 ffffffff8137e4e3 ffffffff81801ee8
[ 45.380462] ffffffff8107b216 ffff880227b386d0 0000000000000000 0000000000000000
[ 45.380462] ffff88023bee7780 ffffffff81801f18 ffffffff810707b2 ffffffff81801fd8
[ 45.380462] Call Trace:
[ 45.380462] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.380462] [<ffffffff8107b216>] lockdep_rcu_suspicious+0xfc/0x105
[ 45.380462] [<ffffffff810707b2>] trace_cpu_idle_rcuidle+0xf2/0xff
[ 45.380462] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.380462] [<ffffffff813689e5>] rest_init+0x149/0x150
[ 45.380462] [<ffffffff8136889c>] ? csum_partial_copy_generic+0x16c/0x16c
[ 45.380462] [<ffffffff81a82d34>] start_kernel+0x3f0/0x3fd
[ 45.380462] [<ffffffff81a8274c>] ? repair_env_string+0x5a/0x5a
[ 45.380462] [<ffffffff81a82481>] x86_64_start_reservations+0x2a/0x2c
[ 45.380462] [<ffffffff81a82550>] x86_64_start_kernel+0xcd/0xd1
[ 45.380462]
[ 45.380462] ===============================
[ 45.380462] [ INFO: suspicious RCU usage. ]
[ 45.380462] 3.10.0-rc1 #86 Tainted: G W
[ 45.380462] -------------------------------
[ 45.380462] include/linux/rcupdate.h:771 rcu_read_lock() used illegally while idle!
[ 45.380462]
[ 45.380462] other info that might help us debug this:
[ 45.380462]
[ 45.380462]
[ 45.380462] RCU used illegally from idle CPU!
[ 45.380462] rcu_scheduler_active = 1, debug_locks = 1
[ 45.380462] RCU used illegally from extended quiescent state!
[ 45.380462] 1 lock held by swapper/0/0:
[ 45.380462] #0: (rcu_read_lock){.+.+..}, at: [<ffffffff810c242b>] rcu_lock_acquire+0x0/0x29
[ 45.557431]
[ 45.557432] ===============================
[ 45.557433] [ INFO: suspicious RCU usage. ]
[ 45.557435] 3.10.0-rc1 #86 Tainted: G W
[ 45.557436] -------------------------------
[ 45.557438] include/linux/rcupdate.h:771 rcu_read_lock() used illegally while idle!
[ 45.557439]
[ 45.557439] other info that might help us debug this:
[ 45.557439]
[ 45.557441]
[ 45.557441] RCU used illegally from idle CPU!
[ 45.557441] rcu_scheduler_active = 1, debug_locks = 1
[ 45.557443] RCU used illegally from extended quiescent state!
[ 45.557444] 2 locks held by swapper/1/0:
[ 45.557453] #0: (rcu_read_lock){.+.+..}, at: [<ffffffff810c242b>] rcu_lock_acquire+0x0/0x29
[ 45.557461] #1: (rcu_read_lock){.+.+..}, at: [<ffffffff810cabac>] perf_output_begin+0x0/0x2be
[ 45.557462]
[ 45.557462] stack backtrace:
[ 45.557465] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 3.10.0-rc1 #86
[ 45.557467] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.557472] 0000000000000001 ffff88023251db28 ffffffff8137e4e3 ffff88023251db58
[ 45.557476] ffffffff8107b216 ffff880216171800 ffff88023251dc68 ffff88023251dd30
[ 45.557480] 0000000000000030 ffff88023251dc48 ffffffff810cac38 ffffffff810cabac
[ 45.557481] Call Trace:
[ 45.557485] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.557489] [<ffffffff8107b216>] lockdep_rcu_suspicious+0xfc/0x105
[ 45.557493] [<ffffffff810cac38>] perf_output_begin+0x8c/0x2be
[ 45.557496] [<ffffffff810cabac>] ? perf_output_copy+0x74/0x74
[ 45.557500] [<ffffffff81079b49>] ? trace_hardirqs_off_caller+0x37/0xa6
[ 45.557504] [<ffffffff81079bc5>] ? trace_hardirqs_off+0xd/0xf
[ 45.557510] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557515] [<ffffffff810c273a>] ? __perf_event_header__init_id+0x5c/0xbc
[ 45.557518] [<ffffffff810c7ecc>] ? perf_prepare_sample+0x57/0x283
[ 45.557522] [<ffffffff810c8255>] __perf_event_overflow+0x15d/0x1c2
[ 45.557526] [<ffffffff810c841d>] perf_swevent_overflow+0x41/0x5b
[ 45.557530] [<ffffffff810c84a8>] perf_swevent_event+0x71/0x73
[ 45.557533] [<ffffffff810c8c28>] perf_tp_event+0xd7/0x24c
[ 45.557537] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557542] [<ffffffff810c0f25>] perf_trace_cpu+0x8b/0x99
[ 45.557546] [<ffffffff810c0ebf>] ? perf_trace_cpu+0x25/0x99
[ 45.557550] [<ffffffff8107074f>] trace_cpu_idle_rcuidle+0x8f/0xff
[ 45.557553] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.557557] [<ffffffff8137224e>] start_secondary+0x261/0x263
[ 45.557559]
[ 45.557560] ===============================
[ 45.557561] [ INFO: suspicious RCU usage. ]
[ 45.557562] 3.10.0-rc1 #86 Tainted: G W
[ 45.557563] -------------------------------
[ 45.557565] kernel/events/ring_buffer.c:132 suspicious rcu_dereference_check() usage!
[ 45.557566]
[ 45.557566] other info that might help us debug this:
[ 45.557566]
[ 45.557568]
[ 45.557568] RCU used illegally from idle CPU!
[ 45.557568] rcu_scheduler_active = 1, debug_locks = 1
[ 45.557569] RCU used illegally from extended quiescent state!
[ 45.557570] 2 locks held by swapper/1/0:
[ 45.557578] #0: (rcu_read_lock){.+.+..}, at: [<ffffffff810c242b>] rcu_lock_acquire+0x0/0x29
[ 45.557584] #1: (rcu_read_lock){.+.+..}, at: [<ffffffff810cabac>] perf_output_begin+0x0/0x2be
[ 45.557585]
[ 45.557585] stack backtrace:
[ 45.557588] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 3.10.0-rc1 #86
[ 45.557589] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.557594] 0000000000000001 ffff88023251db28 ffffffff8137e4e3 ffff88023251db58
[ 45.557598] ffffffff8107b216 ffff880216171000 ffff88023251dc68 ffff880216171800
[ 45.557602] 0000000000000030 ffff88023251dc48 ffffffff810caca9 ffffffff810cabac
[ 45.557603] Call Trace:
[ 45.557606] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.557610] [<ffffffff8107b216>] lockdep_rcu_suspicious+0xfc/0x105
[ 45.557614] [<ffffffff810caca9>] perf_output_begin+0xfd/0x2be
[ 45.557617] [<ffffffff810cabac>] ? perf_output_copy+0x74/0x74
[ 45.557621] [<ffffffff81079b49>] ? trace_hardirqs_off_caller+0x37/0xa6
[ 45.557624] [<ffffffff81079bc5>] ? trace_hardirqs_off+0xd/0xf
[ 45.557628] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557632] [<ffffffff810c273a>] ? __perf_event_header__init_id+0x5c/0xbc
[ 45.557636] [<ffffffff810c7ecc>] ? perf_prepare_sample+0x57/0x283
[ 45.557640] [<ffffffff810c8255>] __perf_event_overflow+0x15d/0x1c2
[ 45.557644] [<ffffffff810c841d>] perf_swevent_overflow+0x41/0x5b
[ 45.557647] [<ffffffff810c84a8>] perf_swevent_event+0x71/0x73
[ 45.557651] [<ffffffff810c8c28>] perf_tp_event+0xd7/0x24c
[ 45.557655] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557659] [<ffffffff810c0f25>] perf_trace_cpu+0x8b/0x99
[ 45.557663] [<ffffffff810c0ebf>] ? perf_trace_cpu+0x25/0x99
[ 45.557666] [<ffffffff8107074f>] trace_cpu_idle_rcuidle+0x8f/0xff
[ 45.557670] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.557673] [<ffffffff8137224e>] start_secondary+0x261/0x263
[ 45.557676]
[ 45.557677] ===============================
[ 45.557677] [ INFO: suspicious RCU usage. ]
[ 45.557679] 3.10.0-rc1 #86 Tainted: G W
[ 45.557680] -------------------------------
[ 45.557682] include/linux/rcupdate.h:792 rcu_read_unlock() used illegally while idle!
[ 45.557683]
[ 45.557683] other info that might help us debug this:
[ 45.557683]
[ 45.557684]
[ 45.557684] RCU used illegally from idle CPU!
[ 45.557684] rcu_scheduler_active = 1, debug_locks = 1
[ 45.557685] RCU used illegally from extended quiescent state!
[ 45.557687] 2 locks held by swapper/1/0:
[ 45.557694] #0: (rcu_read_lock){.+.+..}, at: [<ffffffff810c242b>] rcu_lock_acquire+0x0/0x29
[ 45.557700] #1: (rcu_read_lock){.+.+..}, at: [<ffffffff810cabac>] perf_output_begin+0x0/0x2be
[ 45.557701]
[ 45.557701] stack backtrace:
[ 45.557704] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 3.10.0-rc1 #86
[ 45.557705] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.557710] 0000000000000001 ffff88023251dbf8 ffffffff8137e4e3 ffff88023251dc28
[ 45.557714] ffffffff8107b216 ffff880216171800 0000000000000000 ffff88023251dd30
[ 45.557718] ffff88023251de10 ffff88023251dc38 ffffffff810caac8 ffff88023251dc48
[ 45.557719] Call Trace:
[ 45.557722] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.557726] [<ffffffff8107b216>] lockdep_rcu_suspicious+0xfc/0x105
[ 45.557730] [<ffffffff810caac8>] rcu_read_unlock+0x3e/0x67
[ 45.557733] [<ffffffff810caecf>] perf_output_end+0xe/0x10
[ 45.557737] [<ffffffff810c8275>] __perf_event_overflow+0x17d/0x1c2
[ 45.557741] [<ffffffff810c841d>] perf_swevent_overflow+0x41/0x5b
[ 45.557744] [<ffffffff810c84a8>] perf_swevent_event+0x71/0x73
[ 45.557748] [<ffffffff810c8c28>] perf_tp_event+0xd7/0x24c
[ 45.557752] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557756] [<ffffffff810c0f25>] perf_trace_cpu+0x8b/0x99
[ 45.557760] [<ffffffff810c0ebf>] ? perf_trace_cpu+0x25/0x99
[ 45.557764] [<ffffffff8107074f>] trace_cpu_idle_rcuidle+0x8f/0xff
[ 45.557768] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.557771] [<ffffffff8137224e>] start_secondary+0x261/0x263
[ 45.557773]
[ 45.557774] ===============================
[ 45.557775] [ INFO: suspicious RCU usage. ]
[ 45.557777] 3.10.0-rc1 #86 Tainted: G W
[ 45.557778] -------------------------------
[ 45.557779] include/linux/rcupdate.h:792 rcu_read_unlock() used illegally while idle!
[ 45.557780]
[ 45.557780] other info that might help us debug this:
[ 45.557780]
[ 45.557782]
[ 45.557782] RCU used illegally from idle CPU!
[ 45.557782] rcu_scheduler_active = 1, debug_locks = 1
[ 45.557783] RCU used illegally from extended quiescent state!
[ 45.557785] 1 lock held by swapper/1/0:
[ 45.557791] #0: (rcu_read_lock){.+.+..}, at: [<ffffffff810c242b>] rcu_lock_acquire+0x0/0x29
[ 45.557792]
[ 45.557792] stack backtrace:
[ 45.557795] CPU: 1 PID: 0 Comm: swapper/1 Tainted: G W 3.10.0-rc1 #86
[ 45.557796] Hardware name: LENOVO 2776LEG/2776LEG, BIOS 6EET55WW (3.15 ) 12/19/2011
[ 45.557801] 0000000000000001 ffff88023251dc08 ffffffff8137e4e3 ffff88023251dc38
[ 45.557804] ffffffff8107b216 ffff880216171800 0000000000000000 ffff88023251dd30
[ 45.557808] ffff88023251de10 ffff88023251dc48 ffffffff810c4ad0 ffff88023251dcc8
[ 45.557809] Call Trace:
[ 45.557813] [<ffffffff8137e4e3>] dump_stack+0x19/0x1b
[ 45.557817] [<ffffffff8107b216>] lockdep_rcu_suspicious+0xfc/0x105
[ 45.557821] [<ffffffff810c4ad0>] rcu_read_unlock+0x3e/0x67
[ 45.557824] [<ffffffff810c827a>] __perf_event_overflow+0x182/0x1c2
[ 45.557829] [<ffffffff810c841d>] perf_swevent_overflow+0x41/0x5b
[ 45.557832] [<ffffffff810c84a8>] perf_swevent_event+0x71/0x73
[ 45.557836] [<ffffffff810c8c28>] perf_tp_event+0xd7/0x24c
[ 45.557840] [<ffffffff810603b8>] ? local_clock+0x2b/0x3c
[ 45.557844] [<ffffffff810c0f25>] perf_trace_cpu+0x8b/0x99
[ 45.557848] [<ffffffff810c0ebf>] ? perf_trace_cpu+0x25/0x99
[ 45.557852] [<ffffffff8107074f>] trace_cpu_idle_rcuidle+0x8f/0xff
[ 45.557856] [<ffffffff810708ab>] cpu_startup_entry+0x6c/0x115
[ 45.557859] [<ffffffff8137224e>] start_secondary+0x261/0x263
[ 45.557864] ------------[ cut here ]------------
Bjørn
View attachment "config-3.10.0-rc1" of type "text/plain" (96630 bytes)
Powered by blists - more mailing lists