From owner-freebsd-questions@freebsd.org Mon Aug 23 06:07:27 2021 Return-Path: Delivered-To: freebsd-questions@mailman.nyi.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2610:1c1:1:606c::19:1]) by mailman.nyi.freebsd.org (Postfix) with ESMTP id AB902663DE8 for ; Mon, 23 Aug 2021 06:07:27 +0000 (UTC) (envelope-from parv.0zero9@gmail.com) Received: from mail-wr1-x434.google.com (mail-wr1-x434.google.com [IPv6:2a00:1450:4864:20::434]) (using TLSv1.3 with cipher TLS_AES_128_GCM_SHA256 (128/128 bits) key-exchange X25519 server-signature RSA-PSS (4096 bits) server-digest SHA256 client-signature RSA-PSS (2048 bits) client-digest SHA256) (Client CN "smtp.gmail.com", Issuer "GTS CA 1O1" (verified OK)) by mx1.freebsd.org (Postfix) with ESMTPS id 4GtMGQ4zWHz4ZkX for ; Mon, 23 Aug 2021 06:07:26 +0000 (UTC) (envelope-from parv.0zero9@gmail.com) Received: by mail-wr1-x434.google.com with SMTP id k8so24490426wrn.3 for ; Sun, 22 Aug 2021 23:07:26 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20161025; h=mime-version:from:date:message-id:subject:to; bh=YHVvCvQd68LCP6RzgvXdh8QOT2vz/5B61oTlFBvi6Qc=; b=X40Z2NaViUGYp3ISJPTpdGTY5Wh7SIcJMgIJWdrhx1PbNr0FYXsM/f2Ro1sGnGjq+0 TDNwn3h3tyKxd8NwcGK3o13OApjs7SnEiWOeoXxmQH72DjrdSwlGHeIpl2nWZogvwT1q +TVY2kwHfY9Bs5a1Eo2YSfe1VJfrTBGTiCf6CSVOXelmWcI5UfaIwW9enEgRKZUM37j9 IrRiJHZunyEOd/BQlTHVkA9pQKKa/DcqvyJV8b8II6sm2Q4104pj/Q9lFQfjlqPo3fVR RlVovqBBx0v5z7jY2TW7oV+WYMOnm1vTfZRH//QiRzob5jnFxZase3dLg4sFEu0Zuh/1 H77Q== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20161025; h=x-gm-message-state:mime-version:from:date:message-id:subject:to; bh=YHVvCvQd68LCP6RzgvXdh8QOT2vz/5B61oTlFBvi6Qc=; b=e9B0xSF+XjVKRfixZaAUNU8+pRAIry6O9mk12NsWPqSqmTraO1KdjrO3qX3NMcqgzK MFDJIjYR5Nc+n1d7Vj6VF0uvP9zDVYjunQsz3BO2wt9ewKwKUz6hTtc1NiewvbP4fOgL wUNvQ1qTerfmbR8SD60W70Ss26NwGWFL1od06Nj3j8biF9dhJxr4fH5Gts/qOSnvRsZW MpSyXFvwUj8r6PooXr/S9uPUaZsjg5DTKyFIyogE+6TACHNhlzzFa3vFri8qUU1rvShO wqE3RukWEJQNcSyhlUARARO96d0+zj6TCLVexhvIXzghhDz1zOwI5F+l0q1fPv0GS+z4 f9BA== X-Gm-Message-State: AOAM532bmKYlTdm9NeuX0TFoI7SgwUv8zhMzaI1HLjUWOFUADx8CGDl2 kBCfpqp4WnwR9QKs5ntd57P4FX6qqiUVAp9imC9g/Dqp4LY= X-Google-Smtp-Source: ABdhPJyQeSvu7XY5bM9Cpxxy7JeoBY7VUKISEPbMO5D3NXCmw2wnwri9xvRdmyAVK+qtlRsShbtxwNiIHDSgL6YMTYY= X-Received: by 2002:adf:f490:: with SMTP id l16mr10089768wro.136.1629698845657; Sun, 22 Aug 2021 23:07:25 -0700 (PDT) MIME-Version: 1.0 From: "parv/freebsd" Date: Sun, 22 Aug 2021 20:05:52 -1000 Message-ID: Subject: NFS v3 - FreeBSD 12 server connection getting timed out on CentOS 8 client To: freebsd-questions@freebsd.org X-Rspamd-Queue-Id: 4GtMGQ4zWHz4ZkX X-Spamd-Bar: / Authentication-Results: mx1.freebsd.org; dkim=pass header.d=gmail.com header.s=20161025 header.b=X40Z2NaV; dmarc=pass (policy=none) header.from=gmail.com; spf=pass (mx1.freebsd.org: domain of parv0zero9@gmail.com designates 2a00:1450:4864:20::434 as permitted sender) smtp.mailfrom=parv0zero9@gmail.com X-Spamd-Result: default: False [-0.47 / 15.00]; R_SPF_ALLOW(-0.20)[+ip6:2a00:1450:4000::/36:c]; FREEMAIL_FROM(0.00)[gmail.com]; TO_DN_NONE(0.00)[]; MID_RHS_MATCH_FROMTLD(0.00)[]; DKIM_TRACE(0.00)[gmail.com:+]; DMARC_POLICY_ALLOW(-0.50)[gmail.com,none]; FROM_EQ_ENVFROM(0.00)[]; MIME_TRACE(0.00)[0:+,1:+,2:~]; FREEMAIL_ENVFROM(0.00)[gmail.com]; ASN(0.00)[asn:15169, ipnet:2a00:1450::/32, country:US]; TAGGED_FROM(0.00)[freebsd]; DWL_DNSWL_NONE(0.00)[gmail.com:dkim]; ARC_NA(0.00)[]; NEURAL_HAM_MEDIUM(-0.13)[-0.130]; R_DKIM_ALLOW(-0.20)[gmail.com:s=20161025]; FROM_HAS_DN(0.00)[]; TO_MATCH_ENVRCPT_ALL(0.00)[]; NEURAL_HAM_LONG(-0.34)[-0.338]; MIME_GOOD(-0.10)[multipart/alternative,text/plain]; PREVIOUSLY_DELIVERED(0.00)[freebsd-questions@freebsd.org]; RCPT_COUNT_ONE(0.00)[1]; NEURAL_SPAM_SHORT(1.00)[1.000]; RCVD_IN_DNSWL_NONE(0.00)[2a00:1450:4864:20::434:from]; RCVD_COUNT_TWO(0.00)[2]; RCVD_TLS_ALL(0.00)[]; MAILMAN_DEST(0.00)[freebsd-questions] Content-Type: text/plain; charset="UTF-8" X-Content-Filtered-By: Mailman/MimeDel 2.1.34 X-BeenThere: freebsd-questions@freebsd.org X-Mailman-Version: 2.1.34 Precedence: list List-Id: User questions List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Mon, 23 Aug 2021 06:07:27 -0000 Hi there, CentOS 8 client (host name is replaced with "CentOS8-nfs3-client") ... Linux CentOS8-nfs3-client 4.18.0-305.10.2.el8_4.x86_64 #1 SMP Tue Jul 20 17:25:16 UTC 2021 x86_64 x86_64 x86_64 GNU/Linux ... is having issues connecting to FreeBSD 12 NFS v3 server (host name has been replaced with "FreeBSD-nfsd") ... FreeBSD FreeBSD-nfsd 12.2-RELEASE-p7 FreeBSD 12.2-RELEASE-p7 GENERIC amd64 ... when writing to one of the 2 ZFS pools. On the server, there is not much CPU load; drive activity does not match the connection being timed. On client, CPU getting stuck messages are being printed to everyone when trying to write to the NFS server (a short log is at the end). On the server side, I had not seen any output -- from smartctl or nfsd -- which could indicate such a problem. The client machine had been recently replaced. Same issue was present then, and is now. On the server, I have set "vfs.nfsd.debuglevel=2" to see if there would be any output when the client would complain after connection getting timed out. How do I go about investigating or solve this? - parv A short log from CentOS8-nfs3-client about connection timed out ... Aug 21 08:31:04 CentOS8-nfs3-client kernel: watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [kworker/u24:0:672075] Aug 21 08:31:04 CentOS8-nfs3-client kernel: watchdog: BUG: soft lockup - CPU#1 stuck for 22s! [kworker/u24:10:672632] Aug 21 08:31:04 CentOS8-nfs3-client kernel: watchdog: BUG: soft lockup - CPU#2 stuck for 22s! [kworker/u24:4:672525] Aug 21 08:31:04 CentOS8-nfs3-client kernel: Modules linked in: nfsv3 nfs_acl rpcsec_gss_krb5 auth_rpcgss nfsv4 dns_resolver nfs lockd grace fscache xt_CHECKSUM ipt_MASQUERADE xt_conntrack ipt_REJECT nf_reject_ipv4 nft_compat nft_counter nft_chain_nat nf_nat nf_conntrack nf_defrag_ipv6 nf_defrag_ipv4 nf_tables libcrc32c nfnetlink tun bridge stp llc sunrpc vfat fat intel_rapl_msr intel_rapl_common snd_hda_codec_hdmi snd_sof_pci snd_sof_intel_byt snd_sof_intel_ipc snd_sof_intel_hda_common snd_soc_hdac_hda snd_sof_xtensa_dsp snd_sof_intel_hda snd_hda_codec_realtek snd_sof snd_hda_codec_generic ledtrig_audio snd_soc_skl snd_soc_sst_ipc snd_soc_sst_dsp x86_pkg_temp_thermal intel_powerclamp snd_hda_ext_core coretemp snd_soc_acpi_intel_match snd_soc_acpi kvm_intel snd_hda_intel snd_intel_dspcfg soundwire_intel soundwire_generic_allocation iTCO_wdt mei_wdt iTCO_vendor_support intel_wmi_thunderbolt wmi_bmof snd_soc_core kvm snd_compress soundwire_cadence soundwire_bus irqbypass snd_hda_codec snd_hda_core crct10dif_pclmul Aug 21 08:31:04 CentOS8-nfs3-client kernel: crc32_pclmul snd_hwdep snd_seq ghash_clmulni_intel rapl snd_seq_device intel_cstate snd_pcm intel_uncore snd_timer snd pcspkr soundcore i2c_i801 mei_me mei intel_pch_thermal ie31200_edac wmi acpi_pad intel_pmc_core ip_tables ext4 mbcache jbd2 sd_mod t10_pi sg i915 cec intel_gtt drm_kms_helper syscopyarea sysfillrect sysimgblt fb_sys_fops drm igb ahci e1000e libahci libata dca i2c_algo_bit crc32c_intel video pinctrl_cannonlake fuse Aug 21 08:31:04 CentOS8-nfs3-client kernel: CPU: 2 PID: 672525 Comm: kworker/u24:4 Kdump: loaded Tainted: G W L --------- - - 4.18.0-305.10.2.el8_4.x86_64 #1 Aug 21 08:31:04 CentOS8-nfs3-client kernel: Hardware name: Puget Systems C246M-WU4/C246M-WU4-CF, BIOS F4e 09/16/2020 Aug 21 08:31:04 CentOS8-nfs3-client kernel: Workqueue: rpciod rpc_async_schedule [sunrpc] Aug 21 08:31:04 CentOS8-nfs3-client kernel: RIP: 0010:native_queued_spin_lock_slowpath+0x18f/0x1d0 Aug 21 08:31:04 CentOS8-nfs3-client kernel: Code: c1 e9 12 83 e0 03 83 e9 01 48 c1 e0 05 48 63 c9 48 05 00 ac 02 00 48 03 04 cd a0 b8 b7 a7 48 89 10 8b 42 08 85 c0 75 09 f3 90 <8b> 42 08 85 c0 74 f7 48 8b 02 48 85 c0 0f 84 6e ff ff ff 48 89 c1 Aug 21 08:31:04 CentOS8-nfs3-client kernel: RSP: 0018:ffff9d9bc7f57de8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 Aug 21 08:31:04 CentOS8-nfs3-client kernel: RAX: 0000000000000000 RBX: ffff8a7c795a3000 RCX: 0000000000000004 Aug 21 08:31:04 CentOS8-nfs3-client kernel: RDX: ffff8a8b7c2aac00 RSI: 00000000000c0000 RDI: ffff8a7c795a3670 Aug 21 08:31:04 CentOS8-nfs3-client kernel: RBP: ffff8a7c795a3670 R08: 0000000000100000 R09: 0000000000000000 Aug 21 08:31:04 CentOS8-nfs3-client kernel: R10: ffff8a8a12ef2800 R11: 0000000000000001 R12: ffff8a816e31d310 Aug 21 08:31:04 CentOS8-nfs3-client kernel: R13: 0000000000000000 R14: ffffffffc0c52b20 R15: ffffffffc0c44cf0 Aug 21 08:31:04 CentOS8-nfs3-client kernel: FS: 0000000000000000(0000) GS:ffff8a8b7c280000(0000) knlGS:0000000000000000 Aug 21 08:31:04 CentOS8-nfs3-client kernel: CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 Aug 21 08:31:04 CentOS8-nfs3-client kernel: CR2: 000055af47ebff44 CR3: 0000000eb0610001 CR4: 00000000003706e0 Aug 21 08:31:04 CentOS8-nfs3-client kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 Aug 21 08:31:04 CentOS8-nfs3-client kernel: DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Aug 21 08:31:04 CentOS8-nfs3-client kernel: Call Trace: Aug 21 08:31:04 CentOS8-nfs3-client kernel: _raw_spin_lock+0x1c/0x20 Aug 21 08:31:04 CentOS8-nfs3-client kernel: xprt_prepare_transmit+0x4a/0xb0 [sunrpc] Aug 21 08:31:04 CentOS8-nfs3-client kernel: call_transmit+0x2e/0x80 [sunrpc] Aug 21 08:31:04 CentOS8-nfs3-client kernel: __rpc_execute+0x85/0x3c0 [sunrpc] Aug 21 08:31:04 CentOS8-nfs3-client kernel: ? try_to_wake_up+0x1cd/0x540 Aug 21 08:31:04 CentOS8-nfs3-client kernel: rpc_async_schedule+0x29/0x40 [sunrpc] Aug 21 08:31:04 CentOS8-nfs3-client kernel: process_one_work+0x1a7/0x360 Aug 21 08:31:04 CentOS8-nfs3-client kernel: ? create_worker+0x1a0/0x1a0 Aug 21 08:31:04 CentOS8-nfs3-client kernel: worker_thread+0x30/0x390 Aug 21 08:31:04 CentOS8-nfs3-client kernel: ? create_worker+0x1a0/0x1a0 Aug 21 08:31:04 CentOS8-nfs3-client kernel: kthread+0x116/0x130 Aug 21 08:31:04 CentOS8-nfs3-client kernel: ? kthread_flush_work_fn+0x10/0x10 Aug 21 08:31:04 CentOS8-nfs3-client kernel: ret_from_fork+0x35/0x40 ... similar for many other CPUs ... Aug 21 08:34:06 CentOS8-nfs3-client kernel: rpc_check_timeout: 123 callbacks suppressed Aug 21 08:34:06 CentOS8-nfs3-client kernel: nfs: server FreeBSD-nfsd not responding, timed out