Received: by 2002:ac0:a5b6:0:0:0:0:0 with SMTP id m51-v6csp183443imm; Thu, 31 May 2018 21:53:20 -0700 (PDT) X-Google-Smtp-Source: ADUXVKK3uoUyamFOY4gdxp0zai14loCZi3+uekfemVZniLi+KyKJd2pixsqSuP4cpski0QMz0ne7 X-Received: by 2002:a63:a312:: with SMTP id s18-v6mr7582286pge.187.1527828800912; Thu, 31 May 2018 21:53:20 -0700 (PDT) ARC-Seal: i=1; a=rsa-sha256; t=1527828800; cv=none; d=google.com; s=arc-20160816; b=p+V22N02BfH2Ip+zXAgQkHluRvqvdpGujKAtfbEog+DiJbv//qSm8RgWnuIThdoSsg 0W0WZ1FrFGHHhyA/Yd9gHotx7Zm1B85eqxd74fygiCUTJXxOExLkLiczwI5UVYfPaTOJ 4EaGPUUUQkDGQQ7R//0DADIvbEjk82S+GzDZkGvjDvlzWmv37ic+mMenXnctnKXDQ3t8 W9RwjTAJxKGfv0lLaPohSZ+KbDQkvMwtql/JxGqfPl66vf7E1UmsdsDl34n9F14ahYh3 nH6Enk+0bJKi9xf9y6QhiDdHJFwv/RNtlx1M1MqQXaykQ+OLk1vd0FT2aymfmlWigaRb scxw== ARC-Message-Signature: i=1; a=rsa-sha256; c=relaxed/relaxed; d=google.com; s=arc-20160816; h=list-id:precedence:sender:user-agent:in-reply-to :content-disposition:mime-version:references:message-id:subject:cc :to:from:date:dkim-signature:arc-authentication-results; bh=MzlDLeuBxsGKrZ4NpTHX3yhnFOYuh3GQTOBJf18SY/4=; b=W+uIOqjIlJ2wnHEL/yt1b0dYkaiz1wFaQD0FLP5lW8TOyaMVcbq56WMBd5ipFupUKF MOd/Un5Eyt/QbTkTogUfh9AIBvihyUfeFZ8f2NECSgVEGtfQkdNfGz230R9I5ObtnmNY zfx+SRg1RoM21w98iM+gBI5HkPNgj55RmaRLhDfLyFYFjAgTly4c3P+KPbEZxJIGQJGy P5dvtsSNCcUEXtAVK6bBKnw4l5K1Br+p4A1zT4NAU9ExCGonr4CxcJS0DyoL755xwFof Bt4vJRbLdwkRvJ8S7W2XRFF3oTNvIDH4nCi8j9BJww8/NQafnL0LSftF7dlFUadBYwjY ROPQ== ARC-Authentication-Results: i=1; mx.google.com; dkim=pass header.i=@joelfernandes.org header.s=google header.b=swZIcshy; spf=pass (google.com: best guess record for domain of linux-kernel-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) smtp.mailfrom=linux-kernel-owner@vger.kernel.org Return-Path: Received: from vger.kernel.org (vger.kernel.org. [209.132.180.67]) by mx.google.com with ESMTP id w130-v6si39537524pfd.169.2018.05.31.21.53.06; Thu, 31 May 2018 21:53:20 -0700 (PDT) Received-SPF: pass (google.com: best guess record for domain of linux-kernel-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) client-ip=209.132.180.67; Authentication-Results: mx.google.com; dkim=pass header.i=@joelfernandes.org header.s=google header.b=swZIcshy; spf=pass (google.com: best guess record for domain of linux-kernel-owner@vger.kernel.org designates 209.132.180.67 as permitted sender) smtp.mailfrom=linux-kernel-owner@vger.kernel.org Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1751737AbeFAEwc (ORCPT + 99 others); Fri, 1 Jun 2018 00:52:32 -0400 Received: from mail-pf0-f195.google.com ([209.85.192.195]:46746 "EHLO mail-pf0-f195.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751444AbeFAEwS (ORCPT ); Fri, 1 Jun 2018 00:52:18 -0400 Received: by mail-pf0-f195.google.com with SMTP id p19-v6so7650221pff.13 for ; Thu, 31 May 2018 21:52:17 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=joelfernandes.org; s=google; h=date:from:to:cc:subject:message-id:references:mime-version :content-disposition:in-reply-to:user-agent; bh=MzlDLeuBxsGKrZ4NpTHX3yhnFOYuh3GQTOBJf18SY/4=; b=swZIcshybMLP3bKU9tb0Io1dw54KLKAsCLuAh287U/SDYjbWC599dZ1aAAZTW/3pR/ CkY9dsy8r6T0ojE7u244N+tL5ZuH9zR4TX/pUbigFslmBn9RuAlkQgWyjVa2wDC7oR2N ZmOvAV7TGTmIqKfEtpTMGNQDcXEE2GfX7WgoM= X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20161025; h=x-gm-message-state:date:from:to:cc:subject:message-id:references :mime-version:content-disposition:in-reply-to:user-agent; bh=MzlDLeuBxsGKrZ4NpTHX3yhnFOYuh3GQTOBJf18SY/4=; b=RAHuY1owHColbc9d71F0CRRMMAawDzslSqcU4x0iW+pFqzal9lkzVxO+qLRxlK82Aa 5ajb3OmrsEOrog9HtCxzD0c+zMaIr3tXrtwKZl6jD3CFlBFTXwjHx0LGPXHk2MQwsqlY 6/SnY4H81PxyA3w2KEE6aK+mh9SJBT2IfLh3W9q0OO5Ddp7Jt1kpbmmzWJ6ATHSg1XWA MUwH2Bbd3jbRjXRmvQ3qHWm3Xzw+nq5cGUL7yw7GCRdHlwSrkiZmDQlV6sppWuwnVuAh AqCkzhM04vdJ3mISHnEapEBWUXWvjuAsvWLzNOdhDiQ2TWDrfT83m/PBBPsGt3MoGm4D k3Hw== X-Gm-Message-State: ALKqPwciJ9rk/NwpCXPATZezXrkWxdNxbeplJMdTdEysJJNXQ6ZiyvoL IkUZN/+ZIQBW8WLUeBKlGRoxzw== X-Received: by 2002:a65:628a:: with SMTP id f10-v6mr7682390pgv.6.1527828737346; Thu, 31 May 2018 21:52:17 -0700 (PDT) Received: from localhost ([2620:0:1000:1600:3122:ea9c:d178:eb]) by smtp.gmail.com with ESMTPSA id 76-v6sm91450532pfm.178.2018.05.31.21.52.16 (version=TLS1_2 cipher=ECDHE-RSA-CHACHA20-POLY1305 bits=256/256); Thu, 31 May 2018 21:52:16 -0700 (PDT) Date: Thu, 31 May 2018 21:52:15 -0700 From: Joel Fernandes To: Steven Rostedt Cc: Joel Fernandes , linux-kernel@vger.kernel.org, Peter Zilstra , Ingo Molnar , Mathieu Desnoyers , Tom Zanussi , Namhyung Kim , Thomas Glexiner , Boqun Feng , Paul McKenney , Frederic Weisbecker , Randy Dunlap , Masami Hiramatsu , Fenguang Wu , Baohong Liu , Vedang Patel , stable@vger.kernel.org Subject: Re: [PATCH] softirq: reorder trace_softirqs_on to prevent lockdep splat Message-ID: <20180601045215.GA168630@joelaf.mtv.corp.google.com> References: <20180502014439.87828-1-joelaf@google.com> <20180507142117.35310ff2@gandalf.local.home> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: <20180507142117.35310ff2@gandalf.local.home> User-Agent: Mutt/1.9.2 (2017-12-15) Sender: linux-kernel-owner@vger.kernel.org Precedence: bulk List-ID: X-Mailing-List: linux-kernel@vger.kernel.org On Mon, May 07, 2018 at 02:21:17PM -0400, Steven Rostedt wrote: > Peter, Ingo or Thomas, > > Can you queue this up? Or would you prefer that I take it? This patch is a bug fix, could it be queued for v4.17 -rc cycle or for linux-next? I have also included it below again: thanks, - Joel ---8<----------------------- From: "Joel Fernandes (Google)" Date: Tue, 1 May 2018 18:44:39 -0700 Subject: [PATCH] softirq: reorder trace_softirqs_on to prevent lockdep splat I'm able to reproduce a lockdep splat with config options: CONFIG_PROVE_LOCKING=y, CONFIG_DEBUG_LOCK_ALLOC=y and CONFIG_PREEMPTIRQ_EVENTS=y $ echo 1 > /d/tracing/events/preemptirq/preempt_enable/enable [ 26.112609] DEBUG_LOCKS_WARN_ON(current->softirqs_enabled) [ 26.112636] WARNING: CPU: 0 PID: 118 at kernel/locking/lockdep.c:3854 [...] [ 26.144229] Call Trace: [ 26.144926] [ 26.145506] lock_acquire+0x55/0x1b0 [ 26.146499] ? __do_softirq+0x46f/0x4d9 [ 26.147571] ? __do_softirq+0x46f/0x4d9 [ 26.148646] trace_preempt_on+0x8f/0x240 [ 26.149744] ? trace_preempt_on+0x4d/0x240 [ 26.150862] ? __do_softirq+0x46f/0x4d9 [ 26.151930] preempt_count_sub+0x18a/0x1a0 [ 26.152985] __do_softirq+0x46f/0x4d9 [ 26.153937] irq_exit+0x68/0xe0 [ 26.154755] smp_apic_timer_interrupt+0x271/0x280 [ 26.156056] apic_timer_interrupt+0xf/0x20 [ 26.157105] The issue was this: preempt_count = 1 << SOFTIRQ_SHIFT __local_bh_enable(cnt = 1 << SOFTIRQ_SHIFT) { if (softirq_count() == (cnt && SOFTIRQ_MASK)) { trace_softirqs_on() { current->softirqs_enabled = 1; } } preempt_count_sub(cnt) { trace_preempt_on() { tracepoint() { rcu_read_lock_sched() { // jumps into lockdep Where preempt_count still has softirqs disabled, but current->softirqs_enabled is true, and we get a splat. Cc: stable@vger.kernel.org Reviewed-by: Steven Rostedt (VMware) Fixes: d59158162e032 ("tracing: Add support for preempt and irq enable/disable events") Signed-off-by: Joel Fernandes (Google) --- kernel/softirq.c | 6 +++++- 1 file changed, 5 insertions(+), 1 deletion(-) diff --git a/kernel/softirq.c b/kernel/softirq.c index 177de3640c78..8a040bcaa033 100644 --- a/kernel/softirq.c +++ b/kernel/softirq.c @@ -139,9 +139,13 @@ static void __local_bh_enable(unsigned int cnt) { lockdep_assert_irqs_disabled(); + if (preempt_count() == cnt) + trace_preempt_on(CALLER_ADDR0, get_lock_parent_ip()); + if (softirq_count() == (cnt & SOFTIRQ_MASK)) trace_softirqs_on(_RET_IP_); - preempt_count_sub(cnt); + + __preempt_count_sub(cnt); } /* -- 2.17.0.921.gf22659ad46-goog