From mboxrd@z Thu Jan  1 00:00:00 1970
From: Frederic Weisbecker <fweisbec@gmail.com>
Subject: Re: kvm guest: hrtimer: interrupt too slow
Date: Sat, 10 Oct 2009 11:24:12 +0200
Message-ID: <20091010092410.GA5150@nowhere>
References: <4ACD9AB9.3080803@msgid.tls.msk.ru> <alpine.LFD.2.00.0910081005140.9428@localhost.localdomain> <4ACD9F68.10303@msgid.tls.msk.ru> <alpine.LFD.2.00.0910081127530.9428@localhost.localdomain> <4ACDF1EF.3070005@msgid.tls.msk.ru> <20091008195232.GA8350@amt.cnet> <4ACFA988.6070500@msgid.tls.msk.ru> <20091009222733.GC5859@nowhere> <4ACFBA6E.7030901@msgid.tls.msk.ru> <4AD05158.8030503@msgid.tls.msk.ru>
Mime-Version: 1.0
Content-Type: text/plain; charset=us-ascii
Cc: Marcelo Tosatti <mtosatti@redhat.com>,
	Thomas Gleixner <tglx@linutronix.de>, kvm <kvm@vger.kernel.org>
To: Michael Tokarev <mjt@tls.msk.ru>
Return-path: <kvm-owner@vger.kernel.org>
Received: from ey-out-2122.google.com ([74.125.78.27]:13621 "EHLO
	ey-out-2122.google.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org
	with ESMTP id S1756419AbZJJJZX (ORCPT <rfc822;kvm@vger.kernel.org>);
	Sat, 10 Oct 2009 05:25:23 -0400
Received: by ey-out-2122.google.com with SMTP id 4so354385eyf.5
        for <kvm@vger.kernel.org>; Sat, 10 Oct 2009 02:24:15 -0700 (PDT)
Content-Disposition: inline
In-Reply-To: <4AD05158.8030503@msgid.tls.msk.ru>
Sender: kvm-owner@vger.kernel.org
List-ID: <kvm.vger.kernel.org>

On Sat, Oct 10, 2009 at 01:18:16PM +0400, Michael Tokarev wrote:
> Michael Tokarev wrote:
>> Frederic Weisbecker wrote:
> []
>>>>> Was there swapping going on?
>>>> Not as far as I can see, and sar output agrees.
>>>
>>> But I can read this from you guest traces:
>
> I missed this one yesterday.  Note it's GUEST traces
> indeed.  Higher (read: non-zero) pgp{in,out} and faults
> values happens in *guest*, not on host (original question
> was if we've swapping in HOST, which'd explain the timer
> issues)



Yeah indeed. But still, that's a strange happenstance.



> [cutting extra all-zero columns]
>>>                 pgpgin/s pgpgout/s   fault/s  pgfree/s
>>> 11:44:47         0.00     32.32    907.07       277.78
>>> 11:44:48        27.59     22.99     44.83       150.57
>>> 11:44:49         0.00     33.68     22.11       218.95
>>> [...]
>>> 21:46:54         0.00     31.68     16.83        90.10
>>> 21:46:55         0.00    108.00     17.00        89.00
>>> 21:46:56         9.76    482.93   3890.24       439.02
>>> 21:46:57         0.00    760.00   8627.00      1133.00
>>> 21:46:58         0.00     84.85   2612.12       138.38
>>> 21:46:59         0.00     16.00     17.00        90.00
>>>
>>> So it looks like there was some swapping in when the hrtimer (spuriously)
>>> hanged.
>
> One possible guess.  Since the guest hanged for some time, the
> higher values there might be a result of accumulated values for
> several seconds.



May be yeah. I don't know enough about virtual internals so...