From mboxrd@z Thu Jan  1 00:00:00 1970
Return-Path: <linux-kernel-owner@vger.kernel.org>
Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand
        id S1753536AbcLMKcJ (ORCPT <rfc822;w@1wt.eu>);
        Tue, 13 Dec 2016 05:32:09 -0500
Received: from mail.kernel.org ([198.145.29.136]:45622 "EHLO mail.kernel.org"
        rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP
        id S1753005AbcLMKcI (ORCPT <rfc822;linux-kernel@vger.kernel.org>);
        Tue, 13 Dec 2016 05:32:08 -0500
Date: Tue, 13 Dec 2016 07:32:02 -0300
From: Arnaldo Carvalho de Melo <acme@kernel.org>
To: Namhyung Kim <namhyung@kernel.org>
Cc: Ingo Molnar <mingo@kernel.org>, Peter Zijlstra <peterz@infradead.org>,
        Jiri Olsa <jolsa@kernel.org>, LKML <linux-kernel@vger.kernel.org>,
        David Ahern <dsahern@gmail.com>, Andi Kleen <andi@firstfloor.org>,
        Minchan Kim <minchan@kernel.org>
Subject: Re: [PATCH 1/2] perf sched timehist: Fix --idle-hist when no
 callchains
Message-ID: <20161213103202.GG5482@kernel.org>
References: <20161213080632.19099-1-namhyung@kernel.org>
MIME-Version: 1.0
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
In-Reply-To: <20161213080632.19099-1-namhyung@kernel.org>
X-Url: http://acmel.wordpress.com
User-Agent: Mutt/1.7.1 (2016-10-04)
Sender: linux-kernel-owner@vger.kernel.org
List-ID: <linux-kernel.vger.kernel.org>
X-Mailing-List: linux-kernel@vger.kernel.org

Em Tue, Dec 13, 2016 at 05:06:31PM +0900, Namhyung Kim escreveu:
> When idle hist is enabled, the itr->last_thread should be set so that
> it can find which thread run before idle task.  But it was only set in
> the save_idle_callchain().  This makes idle task doesn't show up in
> the output when callchain is not recorded.

It is important to provide a Fixes: tag so that I can check if the
problem was introduced by some patch still not sent to Ingo, in which
case I could try and merge them, is this the case here?

- Arnaldo 

> Before:
> 
>   $ perf sched timehist --idle-hist
>   Samples do not have callchains.
>              time    cpu  task name             wait time  sch delay   run time
>                           [tid/pid]                (msec)     (msec)     (msec)
>   --------------- ------  --------------------  ---------  ---------  ---------
>     197731.753834 [0001]  perf[27469]               0.000      0.000      0.000
>     197731.753915 [0003]  migration/3[23]           0.000      0.000      0.000
>     197731.754335 [0002]  firefox[17773/17739]      0.000      0.000      0.000
>     197731.754486 [0001]  sleep[27470]              0.000      0.000      0.000
>     197731.754981 [0002]  firefox[17773/17739]      0.000      0.000      0.000
>     197731.755994 [0002]  firefox[17773/17739]      0.000      0.000      0.000
>     ...
> 
> After:
> 
>     197731.753834 [0001]  perf[27469]               0.000      0.000      0.000
>     197731.753914 [0001]  <idle>                    0.000      0.000      0.079
>     197731.753915 [0003]  migration/3[23]           0.000      0.000      0.000
>     197731.754335 [0002]  firefox[17773/17739]      0.000      0.000      0.000
>     197731.754486 [0001]  sleep[27470]              0.000      0.000      0.000
>     197731.754903 [0002]  <idle>                    0.047      0.000      0.567
>     197731.754981 [0002]  firefox[17773/17739]      0.000      0.000      0.567
>     197731.755922 [0002]  <idle>                    0.078      0.000      0.941
>     197731.755994 [0002]  firefox[17773/17739]      0.000      0.000      0.941
>     197731.756625 [0003]  <idle>                    0.123      0.000      2.709
>     ...
> 
> Signed-off-by: Namhyung Kim <namhyung@kernel.org>
> ---
>  tools/perf/builtin-sched.c | 33 +++++++++++++++++----------------
>  1 file changed, 17 insertions(+), 16 deletions(-)
> 
> diff --git a/tools/perf/builtin-sched.c b/tools/perf/builtin-sched.c
> index 0750e938a656..405a91d0515f 100644
> --- a/tools/perf/builtin-sched.c
> +++ b/tools/perf/builtin-sched.c
> @@ -2102,26 +2102,12 @@ static struct thread *get_idle_thread(int cpu)
>  	return idle_threads[cpu];
>  }
>  
> -static void save_idle_callchain(struct thread *thread,
> +static void save_idle_callchain(struct idle_thread_runtime *itr,
>  				struct perf_sample *sample)
>  {
> -	struct thread *idle;
> -	struct idle_thread_runtime *itr;
> -
>  	if (!symbol_conf.use_callchain || sample->callchain == NULL)
>  		return;
>  
> -	idle = get_idle_thread(sample->cpu);
> -	if (idle == NULL) {
> -		pr_err("Failed to get idle thread for cpu %d.\n", sample->cpu);
> -		return;
> -	}
> -
> -	itr = thread__priv(idle);
> -	if (itr == NULL)
> -		return;
> -
> -	itr->last_thread = thread;
>  	callchain_cursor__copy(&itr->cursor, &callchain_cursor);
>  }
>  
> @@ -2179,9 +2165,24 @@ static struct thread *timehist_get_thread(struct perf_sched *sched,
>  
>  		save_task_callchain(sched, sample, evsel, machine);
>  		if (sched->idle_hist) {
> +			struct thread *idle;
> +			struct idle_thread_runtime *itr;
> +
> +			idle = get_idle_thread(sample->cpu);
> +			if (idle == NULL) {
> +				pr_err("Failed to get idle thread for cpu %d.\n", sample->cpu);
> +				return NULL;
> +			}
> +
> +			itr = thread__priv(idle);
> +			if (itr == NULL)
> +				return NULL;
> +
> +			itr->last_thread = thread;
> +
>  			/* copy task callchain when entering to idle */
>  			if (perf_evsel__intval(evsel, sample, "next_pid") == 0)
> -				save_idle_callchain(thread, sample);
> +				save_idle_callchain(itr, sample);
>  		}
>  	}
>  
> -- 
> 2.10.2