From owner-freebsd-acpi@FreeBSD.ORG Fri Nov 9 18:31:45 2012 Return-Path: Delivered-To: freebsd-acpi@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [69.147.83.52]) by hub.freebsd.org (Postfix) with ESMTP id 73B47B69; Fri, 9 Nov 2012 18:31:45 +0000 (UTC) (envelope-from nitroboost@gmail.com) Received: from mail-ea0-f182.google.com (mail-ea0-f182.google.com [209.85.215.182]) by mx1.freebsd.org (Postfix) with ESMTP id CFC4A8FC08; Fri, 9 Nov 2012 18:31:44 +0000 (UTC) Received: by mail-ea0-f182.google.com with SMTP id c10so2052699eaa.13 for ; Fri, 09 Nov 2012 10:31:43 -0800 (PST) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20120113; h=mime-version:in-reply-to:references:date:message-id:subject:from:to :cc:content-type; bh=R6lumVhnxpgaHyeQvuKbqMFXRcyKAexknAQRnAGnweY=; b=yRCKujjdQctmYPNhTjb0k4MhV83h3vVtE8LwlbXnLe4UCVLQ0yjUXoIlNhqLsulhL/ osSdArywLo0u/ZKRtacJbGWKjY+/aJ/+yJed4Ttmixia/LVsBM1FAqUqFAQ1LGRozxXR vVYZHHn+CaBAHE2b6DjENAvxzHjqYEbPhScey3InfQ+LXO40w50NuxKeCiI+TbIqUmUI Dah1W/o0/JzFIXKL/ccV1c3dLrklilB7f6UNqPNAxKneO37IgE+22IYkrjuwuB1+xsvX QKDFX2iV+PnuOTFF+ixkMlVgt2zQTb7dj1f9aNLbYCqaITxgz6j9DH84t2vIFD/xYH8a +mOw== MIME-Version: 1.0 Received: by 10.14.219.2 with SMTP id l2mr40395857eep.3.1352485903661; Fri, 09 Nov 2012 10:31:43 -0800 (PST) Received: by 10.14.218.133 with HTTP; Fri, 9 Nov 2012 10:31:43 -0800 (PST) In-Reply-To: <509CAB8C.1000106@FreeBSD.org> References: <509CAB8C.1000106@FreeBSD.org> Date: Fri, 9 Nov 2012 11:31:43 -0700 Message-ID: Subject: Re: High ACPI CPU usage on a Supermicro X9DRT-HF+ From: Jason Wolfe To: Andriy Gapon Content-Type: text/plain; charset=ISO-8859-1 X-Content-Filtered-By: Mailman/MimeDel 2.1.14 Cc: freebsd-acpi@freebsd.org X-BeenThere: freebsd-acpi@freebsd.org X-Mailman-Version: 2.1.14 Precedence: list List-Id: ACPI and power management development List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 09 Nov 2012 18:31:45 -0000 On Fri, Nov 9, 2012 at 12:06 AM, Andriy Gapon wrote: > on 09/11/2012 04:01 Jason Wolfe said the following: > > Hi, > > > > I'm having an issue with a large pool of Supermicro X9DRT-HF+ servers in > > which the ACPI processes basically burn up a whole CPU. I have ACPI > debug > > mode compiled/enabled, but as I'm not actually having any issues per se, > > I'm having trouble with the next steps. This is fairly new Sandy Bridge > > hardware, so I figure it's possible something needs to be fleshed out in > > the code. Every BIOS option relating to ACPI has been flipped back and > > forth, and booting without ACPI support causes a panic. > > > > Here is the verbose boot log as well as the acpidump -dt output, and > other > > interesting bits: > > > > http://nitrology.com/dmesg.acpi > > http://nitrology.com/jason-X9DRT-HF.asl > > > > sysctl hw.acpi: > > hw.acpi.supported_sleep_state: S1 S4 S5 > > hw.acpi.power_button_state: S5 > > hw.acpi.sleep_button_state: S1 > > hw.acpi.lid_switch_state: NONE > > hw.acpi.standby_state: S1 > > hw.acpi.suspend_state: NONE > > hw.acpi.sleep_delay: 1 > > hw.acpi.s4bios: 0 > > hw.acpi.verbose: 1 > > hw.acpi.disable_on_reboot: 0 > > hw.acpi.handle_reboot: 1 > > hw.acpi.reset_video: 0 > > hw.acpi.cpu.cx_lowest: C1 > > > > vmstat -i: > > interrupt total rate > > irq9: acpi0 12170706 14610 > > cpu0: timer 1662074 1995 > > cpu3: timer 1644465 1974 > > cpu4: timer 1644529 1974 > > cpu1: timer 1644423 1974 > > cpu5: timer 1644498 1974 > > cpu2: timer 1644479 1974 > > > > top -SHb: > > last pid: 1979; load averages: 1.39, 1.35, 0.90 up 0+00:13:54 18:46:27 > > 160 processes: 8 running, 119 sleeping, 33 waiting > > > > Mem: 2355M Active, 11G Inact, 7431M Wired, 216K Cache, 6559M Buf, 41G > Free > > Swap: 24G Total, 24G Free > > > > PID USERNAME PRI NICE SIZE RES STATE C TIME WCPU COMMAND > > 11 root 171 ki31 0K 96K RUN 4 11:52 89.70% idle{idle: cpu4} > > 11 root 171 ki31 0K 96K CPU5 5 11:55 86.67% idle{idle: cpu5} > > 11 root 171 ki31 0K 96K CPU2 2 11:14 84.08% idle{idle: cpu2} > > 11 root 171 ki31 0K 96K CPU3 3 9:56 76.76% idle{idle: cpu3} > > 11 root 171 ki31 0K 96K CPU1 1 9:09 70.90% idle{idle: cpu1} > > 11 root 171 ki31 0K 96K RUN 0 9:24 70.07% idle{idle: cpu0} > > 12 root -52 - 0K 528K WAIT 3 3:25 27.29% intr{irq9: acpi0} > > 0 root 8 0 0K 320K CPU4 4 3:39 25.59% kernel{acpi_task_2} > > 0 root 8 0 0K 320K - 2 3:40 25.39% kernel{acpi_task_0} > > 0 root 8 0 0K 320K - 5 3:39 25.20% kernel{acpi_task_1} > > As a first step please add the following to the loader.conf and see what > gets > reported and at what frequency: > debug.acpi.layer="ACPI_EVENTS" > debug.acpi.level="ACPI_LV_INFO > > Also, is your system DTrace-enabled? > > -- > Andriy Gapon > Andriy, I've enabled the info debug level, here is the mere 1600 line resulting boot log. After the system is live I see no ACPI messages being written. I have also enabled DTrace support. http://nitrology.com/acpi.verbose.info Jason