From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: X-Spam-Checker-Version: SpamAssassin 3.4.0 (2014-02-07) on aws-us-west-2-korg-lkml-1.web.codeaurora.org X-Spam-Level: X-Spam-Status: No, score=-0.8 required=3.0 tests=DKIMWL_WL_HIGH,DKIM_SIGNED, DKIM_VALID,DKIM_VALID_AU,HEADER_FROM_DIFFERENT_DOMAINS,MAILING_LIST_MULTI, SPF_HELO_NONE,SPF_PASS,UNPARSEABLE_RELAY autolearn=no autolearn_force=no version=3.4.0 Received: from mail.kernel.org (mail.kernel.org [198.145.29.99]) by smtp.lore.kernel.org (Postfix) with ESMTP id A2A6CC43603 for ; Tue, 10 Dec 2019 16:27:24 +0000 (UTC) Received: from vger.kernel.org (vger.kernel.org [209.132.180.67]) by mail.kernel.org (Postfix) with ESMTP id 740EA20828 for ; Tue, 10 Dec 2019 16:27:24 +0000 (UTC) Authentication-Results: mail.kernel.org; dkim=pass (2048-bit key) header.d=oracle.com header.i=@oracle.com header.b="MVLShwdO" Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S1727178AbfLJQ1X (ORCPT ); Tue, 10 Dec 2019 11:27:23 -0500 Received: from aserp2120.oracle.com ([141.146.126.78]:60482 "EHLO aserp2120.oracle.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1727177AbfLJQ1X (ORCPT ); Tue, 10 Dec 2019 11:27:23 -0500 Received: from pps.filterd (aserp2120.oracle.com [127.0.0.1]) by aserp2120.oracle.com (8.16.0.27/8.16.0.27) with SMTP id xBAGOQqc026976; Tue, 10 Dec 2019 16:27:17 GMT DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=oracle.com; h=from : content-type : content-transfer-encoding : mime-version : subject : message-id : date : cc : to; s=corp-2019-08-05; bh=zwUDAJqbmNBFUJmgqRPCyKOhizsZwq41Wad7HbySJtw=; b=MVLShwdOB8pUEwJ5Iaus92GMxNDHBG3utjMsDWdHauRe9zRS4OIoTR/H2VioKNFz1gHY OzgTFsYtMBHvToXdDem5BuhVDfBKRo0HBACl4AYiBPtVsgdA6YOnENe2H+8J8o/vH4hO dhuvUXR3k5j9E3QXy3tVLwrnIaXBqys1Lg1BeOVENIEguew1HI5/qBi7s0vGTc6u+ESR XobeWwzsq/ygyZfQ8I2H7eycre3ylYxtm0ZCpAMJwpd0dKLBV23wJTaDqPraCx1ut5oL Q0I8AsEcGy+CO5/Hh9TViFQOUONEK4S+Oq2fgAbHJSodb+4yVssb3tqQcUrClSPz2UcR uA== Received: from aserp3030.oracle.com (aserp3030.oracle.com [141.146.126.71]) by aserp2120.oracle.com with ESMTP id 2wr41q7apj-1 (version=TLSv1.2 cipher=ECDHE-RSA-AES256-GCM-SHA384 bits=256 verify=OK); Tue, 10 Dec 2019 16:27:17 +0000 Received: from pps.filterd (aserp3030.oracle.com [127.0.0.1]) by aserp3030.oracle.com (8.16.0.27/8.16.0.27) with SMTP id xBAGPHHr185540; Tue, 10 Dec 2019 16:27:17 GMT Received: from aserv0122.oracle.com (aserv0122.oracle.com [141.146.126.236]) by aserp3030.oracle.com with ESMTP id 2wt13dc32n-1 (version=TLSv1.2 cipher=ECDHE-RSA-AES256-GCM-SHA384 bits=256 verify=OK); Tue, 10 Dec 2019 16:27:17 +0000 Received: from abhmp0017.oracle.com (abhmp0017.oracle.com [141.146.116.23]) by aserv0122.oracle.com (8.14.4/8.14.4) with ESMTP id xBAGRG4H013220; Tue, 10 Dec 2019 16:27:16 GMT Received: from anon-dhcp-152.1015granger.net (/68.61.232.219) by default (Oracle Beehive Gateway v4.0) with ESMTP ; Tue, 10 Dec 2019 08:27:16 -0800 From: Chuck Lever Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: quoted-printable Mime-Version: 1.0 (Mac OS X Mail 12.4 \(3445.104.11\)) Subject: CPU lockup in or near new filecache code Message-Id: <9977648B-7D14-42EB-BD4A-CBD041A0C21A@oracle.com> Date: Tue, 10 Dec 2019 11:27:15 -0500 Cc: Linux NFS Mailing List To: Bruce Fields , Jeff Layton X-Mailer: Apple Mail (2.3445.104.11) X-Proofpoint-Virus-Version: vendor=nai engine=6000 definitions=9467 signatures=668685 X-Proofpoint-Spam-Details: rule=notspam policy=default score=0 suspectscore=0 malwarescore=0 phishscore=0 bulkscore=0 spamscore=0 mlxscore=0 mlxlogscore=999 adultscore=0 classifier=spam adjust=0 reason=mlx scancount=1 engine=8.0.1-1911140001 definitions=main-1912100141 X-Proofpoint-Virus-Version: vendor=nai engine=6000 definitions=9467 signatures=668685 X-Proofpoint-Spam-Details: rule=notspam policy=default score=0 priorityscore=1501 malwarescore=0 suspectscore=0 phishscore=0 bulkscore=0 spamscore=0 clxscore=1011 lowpriorityscore=0 mlxscore=0 impostorscore=0 mlxlogscore=999 adultscore=0 classifier=spam adjust=0 reason=mlx scancount=1 engine=8.0.1-1911140001 definitions=main-1912100141 Sender: linux-nfs-owner@vger.kernel.org Precedence: bulk List-ID: X-Mailing-List: linux-nfs@vger.kernel.org Under stress, I'm seeing BUGs similar to this quite a bit on my v5.5-rc1 = NFS server. As near as I can tell, the nfsd thread is looping under = nfsd_file_acquire somewhere. Dec 9 13:22:52 klimt kernel: watchdog: BUG: soft lockup - CPU#0 stuck = for 22s! [nfsd:2002] Dec 9 13:22:52 klimt kernel: Modules linked in: rpcsec_gss_krb5 = ocfs2_dlmfs ocfs2_stack_o2cb ocfs2_dlm ocfs2_nodemanager ocfs2_stackglue = ib_umad ib_ipoib mlx4_ib sb_edac x86_pkg_temp_thermal coretemp kvm_intel = kvm irqbypass ext4 crct10dif_pclmul crc32_pclmul ghash_clmulni_intel = mbcache jbd2 iTCO_wdt iTCO_vendor_support aesni_intel glue_helper = crypto_simd cryptd pcspkr rpcrdma i2c_i801 lpc_ich rdma_ucm mfd_core = ib_iser rdma_cm mei_me mei iw_cm raid0 ib_cm libiscsi sg = scsi_transport_iscsi ioatdma wmi ipmi_si ipmi_devintf ipmi_msghandler = acpi_power_meter nfsd nfs_acl lockd auth_rpcgss grace sunrpc ip_tables = xfs libcrc32c mlx4_en sr_mod cdrom sd_mod qedr ast drm_vram_helper = drm_ttm_helper ttm drm_kms_helper crc32c_intel syscopyarea sysfillrect = sysimgblt fb_sys_fops drm ahci libahci libata igb mlx4_core dca = i2c_algo_bit i2c_core nvme nvme_core qede qed dm_mirror dm_region_hash = dm_log dm_mod crc8 ib_uverbs dax ib_core Dec 9 13:22:52 klimt kernel: CPU: 0 PID: 2002 Comm: nfsd Tainted: G = L 5.5.0-rc1-00002-gc56d8b96a170 #1400 Dec 9 13:22:52 klimt kernel: Hardware name: Supermicro Super = Server/X10SRL-F, BIOS 1.0c 09/09/2015 Dec 9 13:22:52 klimt kernel: RIP: 0010:put_task_struct+0xc/0x28 Dec 9 13:22:52 klimt kernel: Code: 05 11 01 00 75 17 48 c7 c7 b1 b4 eb = 81 31 c0 c6 05 4f 05 11 01 01 e8 a7 ad fd ff 0f 0b c3 48 8d 57 20 83 c8 = ff f0 0f c1 47 20 <83> f8 01 75 05 e9 cf 7e fd ff 85 c0 7f 0d be 03 00 = 00 00 48 89 d7 Dec 9 13:22:52 klimt kernel: RSP: 0018:ffffc90000f7bb88 EFLAGS: = 00000213 ORIG_RAX: ffffffffffffff13 Dec 9 13:22:52 klimt kernel: RAX: 0000000000000002 RBX: = ffff888844120000 RCX: 0000000000000000 Dec 9 13:22:52 klimt kernel: RDX: ffff888844120020 RSI: = 0000000000000000 RDI: ffff888844120000 Dec 9 13:22:52 klimt kernel: RBP: 0000000000000001 R08: = ffff888817527b00 R09: ffffffff8121d707 Dec 9 13:22:52 klimt kernel: R10: ffffc90000f7bbc8 R11: = 000000008e6571d9 R12: ffff888855055750 Dec 9 13:22:52 klimt kernel: R13: 0000000000000000 R14: = ffff88882dcd9320 R15: ffff88881741a8c0 Dec 9 13:22:52 klimt kernel: FS: 0000000000000000(0000) = GS:ffff88885fc00000(0000) knlGS:0000000000000000 Dec 9 13:22:52 klimt kernel: CS: 0010 DS: 0000 ES: 0000 CR0: = 0000000080050033 Dec 9 13:22:52 klimt kernel: CR2: 00007f816a386000 CR3: = 0000000855686003 CR4: 00000000001606f0 Dec 9 13:22:52 klimt kernel: Call Trace: Dec 9 13:22:52 klimt kernel: wake_up_q+0x34/0x40 Dec 9 13:22:52 klimt kernel: __mutex_unlock_slowpath.isra.14+0x9d/0xeb Dec 9 13:22:52 klimt kernel: fsnotify_add_mark+0x53/0x5d Dec 9 13:22:52 klimt kernel: nfsd_file_acquire+0x423/0x576 [nfsd] Dec 9 13:22:52 klimt kernel: nfs4_get_vfs_file+0x14c/0x20f [nfsd] Dec 9 13:22:52 klimt kernel: nfsd4_process_open2+0xcd6/0xd98 [nfsd] Dec 9 13:22:52 klimt kernel: ? fh_verify+0x42e/0x4ef [nfsd] Dec 9 13:22:52 klimt kernel: ? nfsd4_process_open1+0x233/0x29d [nfsd] Dec 9 13:22:52 klimt kernel: nfsd4_open+0x500/0x5cb [nfsd] Dec 9 13:22:52 klimt kernel: nfsd4_proc_compound+0x32a/0x5c7 [nfsd] Dec 9 13:22:52 klimt kernel: nfsd_dispatch+0x102/0x1e2 [nfsd] Dec 9 13:22:52 klimt kernel: svc_process_common+0x3b3/0x65d [sunrpc] Dec 9 13:22:52 klimt kernel: ? svc_xprt_put+0x12/0x21 [sunrpc] Dec 9 13:22:52 klimt kernel: ? nfsd_svc+0x2be/0x2be [nfsd] Dec 9 13:22:52 klimt kernel: ? nfsd_destroy+0x51/0x51 [nfsd] Dec 9 13:22:52 klimt kernel: svc_process+0xf6/0x115 [sunrpc] Dec 9 13:22:52 klimt kernel: nfsd+0xf2/0x149 [nfsd] Dec 9 13:22:52 klimt kernel: kthread+0xf6/0xfb Dec 9 13:22:52 klimt kernel: ? kthread_queue_delayed_work+0x74/0x74 Dec 9 13:22:52 klimt kernel: ret_from_fork+0x3a/0x50 -- Chuck Lever