Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1753307Ab1EXGuu (ORCPT ); Tue, 24 May 2011 02:50:50 -0400 Received: from mail-fx0-f46.google.com ([209.85.161.46]:62411 "EHLO mail-fx0-f46.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1752635Ab1EXGus convert rfc822-to-8bit (ORCPT ); Tue, 24 May 2011 02:50:48 -0400 DomainKey-Signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=mime-version:in-reply-to:references:date:message-id:subject:from:to :cc:content-type:content-transfer-encoding; b=XgfRfo70C3PKWdP3rBEdv/klR530f0VZxUItMfeduf64LCPbgDMwHBmq00nZrVgPzt iuf8msazl7PZC3b7ukhw1lPXZABeIy72g0QuBS6PwNXugwbaLKR8lx6CDwQ0yh6QerWg YDs7uhF12RKeZjKoS4kByLyp7f5du2cXWp3/0= MIME-Version: 1.0 In-Reply-To: <4DDB491A.2070901@gmail.com> References: <4DDB491A.2070901@gmail.com> Date: Mon, 23 May 2011 23:50:46 -0700 Message-ID: Subject: Re: INFO: suspicious rcu_dereference_check() usage. From: Justin Mattock To: "linux-kernel@vger.kernel.org" Cc: netdev Content-Type: text/plain; charset=ISO-8859-1 Content-Transfer-Encoding: 8BIT Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 9558 Lines: 185 On Mon, May 23, 2011 at 10:58 PM, Justin P. Mattock wrote: > seems this is just info, but probably should post this so you guys are > aware..: > > > > [ 1308.117068] > [ 1308.117072] =================================================== > [ 1308.117080] [ INFO: suspicious rcu_dereference_check() usage. ] > [ 1308.117085] --------------------------------------------------- > [ 1308.117091] kernel/sched_rt.c:1266 invoked rcu_dereference_check() > without protection! > [ 1308.117096] > [ 1308.117097] other info that might help us debug this: > [ 1308.117099] > [ 1308.117104] > [ 1308.117106] rcu_scheduler_active = 1, debug_locks = 1 > [ 1308.117112] 1 lock held by watchdog/1/16: > [ 1308.117116] ?#0: ?(&rq->lock){-.-.-.}, at: [] > post_schedule.part.25+0x14/0x4a > [ 1308.117137] > [ 1308.117139] stack backtrace: > [ 1308.117146] Pid: 16, comm: watchdog/1 Not tainted > 2.6.39-04906-g5e152b4-dirty #2 > [ 1308.117151] Call Trace: > [ 1308.117163] ?[] lockdep_rcu_dereference+0x9a/0xa2 > [ 1308.117172] ?[] find_lowest_rq+0xfe/0x179 > [ 1308.117182] ?[] push_rt_task.part.60+0x7b/0x1c8 > [ 1308.117190] ?[] post_schedule_rt+0x20/0x28 > [ 1308.117198] ?[] post_schedule.part.25+0x30/0x4a > [ 1308.117209] ?[] schedule+0x725/0x773 > [ 1308.117217] ?[] ? watchdog_enable+0x198/0x198 > [ 1308.117226] ?[] ? cpu_clock+0x47/0x51 > [ 1308.117234] ?[] ? watchdog_enable+0x198/0x198 > [ 1308.117241] ?[] watchdog+0x6d/0xb0 > [ 1308.117249] ?[] kthread+0xa8/0xb0 > [ 1308.117259] ?[] kernel_thread_helper+0x4/0x10 > [ 1308.117268] ?[] ? retint_restore_args+0x13/0x13 > [ 1308.117276] ?[] ? __init_kthread_worker+0x5a/0x5a > [ 1308.117283] ?[] ? gs_change+0x13/0x13 > [ 1308.117675] > [ 1308.117678] =================================================== > [ 1308.117685] [ INFO: suspicious rcu_dereference_check() usage. ] > [ 1308.117690] --------------------------------------------------- > [ 1308.117695] kernel/sched.c:619 invoked rcu_dereference_check() without > protection! > [ 1308.117700] > [ 1308.117701] other info that might help us debug this: > [ 1308.117704] > [ 1308.117708] > [ 1308.117710] rcu_scheduler_active = 1, debug_locks = 1 > [ 1308.117715] 2 locks held by rcuc0/7: > [ 1308.117719] ?#0: ?(&rq->lock){-.-.-.}, at: [] > schedule+0xe1/0x773 > [ 1308.117736] ?#1: ?(&rq->lock/1){..-.-.}, at: [] > double_lock_balance+0x6c/0x78 > [ 1308.117753] > [ 1308.117755] stack backtrace: > [ 1308.117761] Pid: 7, comm: rcuc0 Not tainted 2.6.39-04906-g5e152b4-dirty > #2 > [ 1308.117766] Call Trace: > [ 1308.117776] ?[] lockdep_rcu_dereference+0x9a/0xa2 > [ 1308.117784] ?[] task_group+0x7f/0xbe > [ 1308.117792] ?[] set_task_rq+0x17/0x70 > [ 1308.117800] ?[] set_task_cpu+0xf7/0x14c > [ 1308.117810] ?[] ? plist_check_head+0x9a/0x9e > [ 1308.117818] ?[] ? plist_del+0x70/0x79 > [ 1308.117825] ?[] ? dequeue_task_rt+0x38/0x3d > [ 1308.117833] ?[] ? dequeue_task+0x87/0x8e > [ 1308.117841] ?[] pull_rt_task+0x115/0x169 > [ 1308.117849] ?[] pre_schedule_rt+0x1e/0x20 > [ 1308.117857] ?[] schedule+0x2c9/0x773 > [ 1308.117865] ?[] ? prepare_to_wait+0x6c/0x78 > [ 1308.117875] ?[] rcu_cpu_kthread+0xeb/0x34d > [ 1308.117883] ?[] ? __init_waitqueue_head+0x4b/0x4b > [ 1308.117892] ?[] ? rcu_needs_cpu+0x1bd/0x1bd > [ 1308.117899] ?[] kthread+0xa8/0xb0 > [ 1308.117908] ?[] kernel_thread_helper+0x4/0x10 > [ 1308.117916] ?[] ? retint_restore_args+0x13/0x13 > [ 1308.117924] ?[] ? __init_kthread_worker+0x5a/0x5a > [ 1308.117933] ?[] ? gs_change+0x13/0x13 > > > full dmesg is here: > http://fpaste.org/IqRy/ > > Justin P. Mattock > well, after posting the above, I noticed some others as well. (system got sluggish, but is responsive). [ 2862.310349] WARNING: at net/ipv4/route.c:1668 ip_rt_bug+0x5c/0x62() [ 2862.310353] Hardware name: MacBookPro2,2 [ 2862.310355] Modules linked in: fuse 8021q garp stp cpufreq_ondemand llc acpi_cpufreq freq_table mperf ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 xt_state nf_conntrack iptable_filter ip_tables arc4 ath9k mac80211 radeon ath9k_common ath9k_hw ath cfg80211 btusb bluetooth ttm drm_kms_helper drm uvcvideo joydev microcode appletouch applesmc input_polldev iTCO_wdt videodev iTCO_vendor_support v4l2_compat_ioctl32 i2c_i801 rfkill sky2 i2c_algo_bit i2c_core apple_bl video [last unloaded: scsi_wait_scan] [ 2862.310414] Pid: 6153, comm: gcm-session Not tainted 2.6.39-04906-g5e152b4-dirty #2 [ 2862.310417] Call Trace: [ 2862.310424] [] warn_slowpath_common+0x83/0x9b [ 2862.310430] [] warn_slowpath_null+0x1a/0x1c [ 2862.310434] [] ip_rt_bug+0x5c/0x62 [ 2862.310439] [] dst_output+0x19/0x1d [ 2862.310443] [] ip_local_out+0x20/0x25 [ 2862.310448] [] ip_send_skb+0x19/0x58 [ 2862.310453] [] udp_send_skb+0x239/0x29b [ 2862.310458] [] udp_sendmsg+0x5a1/0x7d4 [ 2862.310464] [] ? trace_hardirqs_off+0xd/0xf [ 2862.310469] [] ? ip_select_ident+0x3d/0x3d [ 2862.310475] [] ? local_bh_enable_ip+0xe/0x10 [ 2862.310481] [] ? _raw_spin_unlock_bh+0x31/0x35 [ 2862.310486] [] ? release_sock+0x14c/0x155 [ 2862.310490] [] inet_sendmsg+0x66/0x6f [ 2862.310495] [] sock_sendmsg+0xe6/0x109 [ 2862.310501] [] ? lock_acquire+0xe1/0x109 [ 2862.310505] [] ? lock_release+0x1aa/0x1d3 [ 2862.310512] [] ? might_fault+0xa5/0xac [ 2862.310516] [] ? copy_from_user+0x2f/0x31 [ 2862.310521] [] sys_sendto+0x132/0x174 [ 2862.310526] [] ? sysret_check+0x2e/0x69 [ 2862.310531] [] ? trace_hardirqs_on_caller+0x13f/0x172 [ 2862.310537] [] ? audit_syscall_entry+0x11c/0x148 [ 2862.310542] [] ? trace_hardirqs_on_thunk+0x3a/0x3f [ 2862.310546] [] system_call_fastpath+0x16/0x1b [ 2862.310549] ---[ end trace 2d2332adaa8bf2b5 ]--- [ 2863.373889] ip_rt_bug: 10.0.0.10 -> 255.255.255.255, ? [ 2863.373903] ------------[ cut here ]------------ [ 2863.373910] WARNING: at net/ipv4/route.c:1668 ip_rt_bug+0x5c/0x62() [ 2863.373919] Hardware name: MacBookPro2,2 [ 2863.373921] Modules linked in: fuse 8021q garp stp cpufreq_ondemand llc acpi_cpufreq freq_table mperf ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 xt_state nf_conntrack iptable_filter ip_tables arc4 ath9k mac80211 radeon ath9k_common ath9k_hw ath cfg80211 btusb bluetooth ttm drm_kms_helper drm uvcvideo joydev microcode appletouch applesmc input_polldev iTCO_wdt videodev iTCO_vendor_support v4l2_compat_ioctl32 i2c_i801 rfkill sky2 i2c_algo_bit i2c_core apple_bl video [last unloaded: scsi_wait_scan] [ 2863.373986] Pid: 6153, comm: gcm-session Tainted: G W 2.6.39-04906-g5e152b4-dirty #2 [ 2863.373989] Call Trace: [ 2863.373996] [] warn_slowpath_common+0x83/0x9b [ 2863.374058] [] warn_slowpath_null+0x1a/0x1c [ 2863.374063] [] ip_rt_bug+0x5c/0x62 [ 2863.374068] [] dst_output+0x19/0x1d [ 2863.374073] [] ip_local_out+0x20/0x25 [ 2863.374079] [] ip_send_skb+0x19/0x58 [ 2863.374084] [] udp_send_skb+0x239/0x29b [ 2863.374089] [] udp_sendmsg+0x5a1/0x7d4 [ 2863.374095] [] ? trace_hardirqs_off+0xd/0xf [ 2863.374100] [] ? ip_select_ident+0x3d/0x3d [ 2863.374106] [] ? local_bh_enable_ip+0xe/0x10 [ 2863.374111] [] ? _raw_spin_unlock_bh+0x31/0x35 [ 2863.374117] [] ? release_sock+0x14c/0x155 [ 2863.374122] [] inet_sendmsg+0x66/0x6f [ 2863.374127] [] sock_sendmsg+0xe6/0x109 [ 2863.374132] [] ? lock_acquire+0xe1/0x109 [ 2863.374137] [] ? lock_release+0x1aa/0x1d3 [ 2863.374143] [] ? might_fault+0xa5/0xac [ 2863.374148] [] ? copy_from_user+0x2f/0x31 [ 2863.374153] [] sys_sendto+0x132/0x174 [ 2863.374158] [] ? sysret_check+0x2e/0x69 [ 2863.374163] [] ? trace_hardirqs_on_caller+0x13f/0x172 [ 2863.374169] [] ? audit_syscall_entry+0x11c/0x148 [ 2863.374175] [] ? trace_hardirqs_on_thunk+0x3a/0x3f [ 2863.374180] [] system_call_fastpath+0x16/0x1b [ 2863.374184] ---[ end trace 2d2332adaa8bf2b6 ]--- full dmesg here: http://fpaste.org/W4UK/ -- Justin P. Mattock -- To unsubscribe from this list: send the line "unsubscribe linux-kernel" in the body of a message to majordomo@vger.kernel.org More majordomo info at http://vger.kernel.org/majordomo-info.html Please read the FAQ at http://www.tux.org/lkml/