Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1754305AbZDOQYA (ORCPT ); Wed, 15 Apr 2009 12:24:00 -0400 Received: (majordomo@vger.kernel.org) by vger.kernel.org id S1752004AbZDOQXu (ORCPT ); Wed, 15 Apr 2009 12:23:50 -0400 Received: from fg-out-1718.google.com ([72.14.220.156]:7322 "EHLO fg-out-1718.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751941AbZDOQXu (ORCPT ); Wed, 15 Apr 2009 12:23:50 -0400 DomainKey-Signature: a=rsa-sha1; c=nofws; d=gmail.com; s=gamma; h=date:from:to:cc:subject:message-id:references:mime-version :content-type:content-disposition:in-reply-to:user-agent; b=PqTfsEDWx4LALZmbn5tFiHkuq5XpElRteYRfS486EvGGnVqOTF5oYHBFPWIiRuaOBL pslnX3fjn6+CFjqq/eeQYfGetg7LCjYrKUB4pWfHlJzl6myYrPVOa0s/+7/yLN+4rTIc qIdK7ESKoK8ywI63F/WSwBXP3VUppEd39yan8= Date: Wed, 15 Apr 2009 18:23:45 +0200 From: Frederic Weisbecker To: KOSAKI Motohiro Cc: Zhaolei , Steven Rostedt , Tom Zanussi , Ingo Molnar , linux-kernel@vger.kernel.org, Oleg Nesterov , Andrew Morton Subject: Re: [PATCH v2 5/4] ftrace, workqueuetrace: display work name Message-ID: <20090415162344.GI5989@nowhere> References: <20090415085310.AC0D.A69D9226@jp.fujitsu.com> <20090415011533.GI5968@nowhere> <20090415141250.AC46.A69D9226@jp.fujitsu.com> MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline In-Reply-To: <20090415141250.AC46.A69D9226@jp.fujitsu.com> User-Agent: Mutt/1.5.18 (2008-05-17) Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org Content-Length: 4078 Lines: 118 On Wed, Apr 15, 2009 at 03:13:17PM +0900, KOSAKI Motohiro wrote: > Hi > > > Kosaki-san, > > > > Perhaps you misunderstood me, which is easy because my english is > > evil ;-) > > hehe, my english is poor much than you ;) > > > > We have to distinguish event tracing and statistical/histogram tracing > > here. > > > > Event tracing is about logging the events when they come and store > > them one by one to output them later. That's what does TRACE_EVENT > > for instance. > > > > Statistical tracing doesn't store a trace of each event but instead > > update some numbers after each event: number of events, maximum > > latency, average, etc... > > Agreed. > > > > About event tracing, we want to have something that let us identifying > > the events individually. For the works it can be either the function > > embedeed in the work, or the work itself. > > But do we need both? Since it's rare that a function can be embedeed in > > more than two works, I guess we only need one of those informations. > > Which one is the more efficient to identify a work? That can be discussed > > actually. > > OK. I think function name is enough. I'll drop this patch. > > And also function name has another benefit. > symbol name is module unload safe. then we don't need to care > module unloading. > > In the other hand, work_struct variable is often static variable. > it mean the variable name is often very short. > > > > When I talked about per-work tracing, it was in a generic way. What do we > > use to identify each work individually: either the function or the work > > name? Both seems accurate for that actually, the fact is that both can > > be used for per-work tracing. > > > > Actually my previous mails were focused on statistical tracing. > > > > You proposed something that would result in the following final view: > > > > workqueue_name:pid n_inserted n_executed cpu max_latency > > > > And then by looking at the trace file, we can retrieve the work/function > > that produced this max latency. > > > > While I proposed this another idea: > > > > workqueue_name:pid n_inserted n_executed cpu > > > > work1 latency_avg latency_max > > work2 latency_avg latency_max > > work3 latency_avg latency_max > > ..... > > > > (We can have it with one file per workqueue). > > work1 can be either the work name or the function executed though > > the function is probably the main focus here because it's the > > real source culprit. > > But we can also output work_name:func > > > > You see? With such output we see immediately which works are creating the > > worst latencies. > > And the event tracing is still very helpful here to have a more > > fine grained tracing and see the behaviour of some works more precisely. > > > > That's a kind of tracing process we can imagine: > > > > - we start by looking at the statistics and indentify the wicked > > works/funcs. > > - we look at the events on /debug/tracing/trace and, coupling with > > some well-chosen filters, we observe the behaviour of a work with > > more precision. > > > > > > But I'm not opposite to your patch, I think it can be helpful to also > > have the work name on certain circumstances. > > But it makes the whole line a bit messy with a lot of informations for > > those who only need the func name (or only the work name). > > The best would be to have a runtime option to choose whether we want > > to display it or not. > > I understand you mean. thanks. > My conclusion is follow, > > Conclusion: > 1/4 resend, but remove __entry->work > 2/4 resend > 3/4 remake as your suggestion > 4/4 remake as your suggestion > 5/4 dropped > > but unfortunately I don't have enough development time. then, > I and Zhaolei discuss this issue and we agreed Zaholei develop it. > > > Thanks! > Ok, thank you! -- 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/