From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1751314AbeEDGhp (ORCPT ); Fri, 4 May 2018 02:37:45 -0400 Received: from smtp.codeaurora.org ([198.145.29.96]:48466 "EHLO smtp.codeaurora.org" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751106AbeEDGhn (ORCPT ); Fri, 4 May 2018 02:37:43 -0400 MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8; format=flowed Content-Transfer-Encoding: 8bit Date: Fri, 04 May 2018 07:37:40 +0100 From: okaya@codeaurora.org To: Bjorn Helgaas Cc: Paul Menzel , Bjorn Helgaas , linux-pci@vger.kernel.org, linux-kernel@vger.kernel.org, Lukas Wunner Subject: Re: pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued 65284 msec ago) In-Reply-To: <20180504024527.GE15790@bhelgaas-glaptop.roam.corp.google.com> References: <8770820b-85a0-172b-7230-3a44524e6c9f@molgen.mpg.de> <20180427192207.GG8199@bhelgaas-glaptop.roam.corp.google.com> <43b8ab4a-f8ee-dc96-40ec-e6fdfedd8309@molgen.mpg.de> <20180504024527.GE15790@bhelgaas-glaptop.roam.corp.google.com> Message-ID: User-Agent: Roundcube Webmail/1.2.5 Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org On 2018-05-04 03:45, Bjorn Helgaas wrote: > On Thu, May 03, 2018 at 10:49:24AM +0200, Paul Menzel wrote: >> On 04/27/18 21:22, Bjorn Helgaas wrote: >> > [+cc Lukas, Sinan] >> >> > On Thu, Apr 26, 2018 at 12:17:53PM +0200, Paul Menzel wrote: >> >> > > On the Lenovo X60t, during resume from ACPI suspend and during shutdown, the >> > > message below is shown in the logs. >> > > >> > > pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 (issued >> > > 65284 msec ago) >> > >> > This is an Intel root port: >> > >> > 00:1c.0 PCI bridge: Intel Corporation NM10/ICH7 Family PCI Express Port 1 (rev 02) (prog-if 00 [Normal decode]) >> > >> > and probably has the CF118 erratum (see >> > http://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git/commit/?id=3461a068661c >> > for details). I bet if you changed "msecs" in pcie_wait_cmd() to 30000 >> > you'd see a 30 second delay during shutdown because we write a command to >> > tell the port not to generate any more hotplug interrupts, and we wait for >> > that command to complete, but the port never tells us it has completed. >> > >> > Lukas reported a similar issue in >> > https://lkml.kernel.org/r/20180112104929.GA10599@wunner.de, which we sort >> > of worked around by assuming that Thunderbolt controllers never support >> > that "command complete" interrupt (see >> > http://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git/commit/?id=493fb50e958c) >> > >> > Sinan mooted the idea of using a "no-wait" path of sending the "don't >> > generate hotplug interrupts" command. I think we should work on this >> > idea a little more. If we're shutting down the whole system, I can't >> > believe there's much value in *anything* we do in the pciehp_remove() >> > path. >> > >> > Maybe we should just get rid of pciehp_remove() (and probably >> > pcie_port_remove_service() and the other service driver remove methods) >> > completely. That dates from when the service drivers could be modules that >> > could be potentially unloaded, but unloading them hasn't been possible for >> > years. >> > >> > As far as the resume path, my guess is that in pciehp_resume(), we >> > write a command to enable interrupts, then it looks like we get a >> > PCI_EXP_SLTSTA_DLLSC "Link Up" interrupt, and apparently we issue >> > another command. Not sure exactly what's going on here. > >> Thank you for the quick reply and sorry for only being able to test it >> now. >> Please find the relevant bits from the ACPI S3 suspend “action” below. >> The >> full log is attached. > > No problem. I think we need to bite the bullet and just do a quirk > for the Intel erratum. I tried to avoid it by waiting for command > completion lazily, but I think that ended up being unnecessarily > clever and it didn't even solve the whole problem. > > Can you try the patch below? I think it should solve the problem > you're seeing. > > > commit ec48a1e0b91ce68903c8ea4dce659d4fdf17ad06 > Author: Bjorn Helgaas > Date: Thu May 3 18:39:38 2018 -0500 > > PCI: pciehp: Add quirk for Intel Command Completed erratum > > The Intel CF118 erratum means the controller does not set the > Command > Completed bit unless writes to the Slot Command register change > "Control" > bits. Command Completed is never set for writes that only change > software > notification "Enable" bits. This results in timeouts like this: > > pciehp 0000:00:1c.0:pcie004: Timeout on hotplug command 0x1038 > (issued 65284 msec ago) > > When this erratum is present, avoid these timeouts by marking > commands > "completed" immediately unless they change the "Control" bits. > > Here's the text of the erratum from the Intel document: > > CF118 PCIe Slot Status Register Command Completed bit not > always > updated on any configuration write to the Slot > Control > Register > > Problem: For PCIe root ports (devices 0 - 10) supporting > hot-plug, > the Slot Status Register (offset AAh) Command > Completed > (bit[4]) status is updated under the following > condition: > IOH will set Command Completed bit after delivering > the new > commands written in the Slot Controller register > (offset > A8h) to VPP. The IOH detects new commands written in > Slot > Control register by checking the change of value for > Power > Controller Control (bit[10]), Power Indicator > Control > (bits[9:8]), Attention Indicator Control > (bits[7:6]), or > Electromechanical Interlock Control (bit[11]) > fields. Any > other configuration writes to the Slot Control > register > without changing the values of these fields will not > cause > Command Completed bit to be set. > > The PCIe Base Specification Revision 2.0 or later > describes > the “Slot Control Register” in section 7.8.10, as > follows > (Reference section 7.8.10, Slot Control Register, > Offset > 18h). In hot-plug capable Downstream Ports, a write > to the > Slot Control register must cause a hot-plug command > to be > generated (see Section 6.7.3.2 for details on > hot-plug > commands). A write to the Slot Control register in a > Downstream Port that is not hotplug capable must not > cause a > hot-plug command to be executed. > > The PCIe Spec intended that every write to the Slot > Control > Register is a command and expected a command > complete status > to abstract the VPP implementation specific nuances > from the > OS software. IOH PCIe Slot Control Register > implementation > is not fully conforming to the PCIe Specification in > this > respect. > > Implication: Software checking on the Command Completed status > after > writing to the Slot Control register may time out. > > Workaround: Software can read the Slot Control register and > compare the > existing and new values to determine if it should > check the > Command Completed status after writing to the Slot > Control > register. > > Link: > http://www.intel.com/content/www/us/en/processors/xeon/xeon-e7-v2-spec-update.html > Link: > https://lkml.kernel.org/r/8770820b-85a0-172b-7230-3a44524e6c9f@molgen.mpg.de > Reported-by: Paul Menzel > Signed-off-by: Bjorn Helgaas > > diff --git a/drivers/pci/hotplug/pciehp.h > b/drivers/pci/hotplug/pciehp.h > index c27aab8e25d7..eefffff8e403 100644 > --- a/drivers/pci/hotplug/pciehp.h > +++ b/drivers/pci/hotplug/pciehp.h > @@ -83,6 +83,7 @@ struct controller { > struct timer_list poll_timer; > unsigned long cmd_started; /* jiffies */ > unsigned int cmd_busy:1; > + unsigned int cc_erratum:1; > unsigned int link_active_reporting:1; > unsigned int notification_enabled:1; > unsigned int power_fault_detected:1; > diff --git a/drivers/pci/hotplug/pciehp_hpc.c > b/drivers/pci/hotplug/pciehp_hpc.c > index 18a42f8f5dc5..aba67d16484a 100644 > --- a/drivers/pci/hotplug/pciehp_hpc.c > +++ b/drivers/pci/hotplug/pciehp_hpc.c > @@ -10,7 +10,6 @@ > * All rights reserved. > * > * Send feedback to , > - * > */ > > #include > @@ -147,25 +146,27 @@ static void pcie_wait_cmd(struct controller > *ctrl) > else > rc = pcie_poll_cmd(ctrl, jiffies_to_msecs(timeout)); > > - /* > - * Controllers with errata like Intel CF118 don't generate > - * completion notifications unless the power/indicator/interlock > - * control bits are changed. On such controllers, we'll emit this > - * timeout message when we wait for completion of commands that > - * don't change those bits, e.g., commands that merely enable > - * interrupts. > - */ > if (!rc) > ctrl_info(ctrl, "Timeout on hotplug command %#06x (issued %u msec > ago)\n", > ctrl->slot_ctrl, > jiffies_to_msecs(jiffies - ctrl->cmd_started)); > } > > +/* > + * The Intel CF118 erratum means the Command Completed bit is only set > if a > + * Slot Control write changes PCI_EXP_SLTCTL_PCC, PCI_EXP_SLTCTL_PIC, > + * PCI_EXP_SLTCTL_AIC, or PCI_EXP_SLTCTL_EIC. > + */ > +#define CC_ERRATUM_MASK (PCI_EXP_SLTCTL_PCC | \ > + PCI_EXP_SLTCTL_PIC | \ > + PCI_EXP_SLTCTL_AIC | \ > + PCI_EXP_SLTCTL_EIC) > + > static void pcie_do_write_cmd(struct controller *ctrl, u16 cmd, > u16 mask, bool wait) > { > struct pci_dev *pdev = ctrl_dev(ctrl); > - u16 slot_ctrl; > + u16 slot_ctrl_orig, slot_ctrl; > > mutex_lock(&ctrl->ctrl_lock); > > @@ -180,6 +181,7 @@ static void pcie_do_write_cmd(struct controller > *ctrl, u16 cmd, > goto out; > } > > + slot_ctrl_orig = slot_ctrl; > slot_ctrl &= ~mask; > slot_ctrl |= (cmd & mask); > ctrl->cmd_busy = 1; > @@ -188,6 +190,10 @@ static void pcie_do_write_cmd(struct controller > *ctrl, u16 cmd, > ctrl->cmd_started = jiffies; > ctrl->slot_ctrl = slot_ctrl; > > + if (ctrl->cc_erratum && > + (slot_ctrl_orig & CC_ERRATUM_MASK) == (slot_ctrl & > CC_ERRATUM_MASK)) > + ctrl->cmd_busy = 0; > + > /* > * Optionally wait for the hardware to be ready for a new command, > * indicating completion of the above issued command. > @@ -840,6 +846,10 @@ struct controller *pcie_init(struct pcie_device > *dev) > if (pdev->is_thunderbolt) > slot_cap |= PCI_EXP_SLTCAP_NCCS; > > + /* Assume all Intel controllers have erratum CF118 */ > + if (pdev->vendor == PCI_VENDOR_ID_INTEL) > + ctrl->cc_erratum = 1; > + Can we build a table like quirks.c? Qdf2400 root ports have the same problem. I will do a follow up patch once this finds its way in. > ctrl->slot_cap = slot_cap; > mutex_init(&ctrl->ctrl_lock); > init_waitqueue_head(&ctrl->queue); > @@ -861,7 +871,7 @@ struct controller *pcie_init(struct pcie_device > *dev) > PCI_EXP_SLTSTA_MRLSC | PCI_EXP_SLTSTA_CC | > PCI_EXP_SLTSTA_DLLSC); > > - ctrl_info(ctrl, "Slot #%d AttnBtn%c PwrCtrl%c MRL%c AttnInd%c > PwrInd%c HotPlug%c Surprise%c Interlock%c NoCompl%c LLActRep%c\n", > + ctrl_info(ctrl, "Slot #%d AttnBtn%c PwrCtrl%c MRL%c AttnInd%c > PwrInd%c HotPlug%c Surprise%c Interlock%c NoCompl%c%s LLActRep%c\n", > (slot_cap & PCI_EXP_SLTCAP_PSN) >> 19, > FLAG(slot_cap, PCI_EXP_SLTCAP_ABP), > FLAG(slot_cap, PCI_EXP_SLTCAP_PCP), > @@ -872,6 +882,7 @@ struct controller *pcie_init(struct pcie_device > *dev) > FLAG(slot_cap, PCI_EXP_SLTCAP_HPS), > FLAG(slot_cap, PCI_EXP_SLTCAP_EIP), > FLAG(slot_cap, PCI_EXP_SLTCAP_NCCS), > + ctrl->cc_erratum? " (with CC erratum)" : "", > FLAG(link_cap, PCI_EXP_LNKCAP_DLLLARC)); > > if (pcie_init_slot(ctrl))