Skip site navigation (1)Skip section navigation (2)
Date:      Wed, 28 Feb 2024 16:04:41 -0800
From:      Rick Macklem <rick.macklem@gmail.com>
To:        Garrett Wollman <wollman@bimajority.org>
Cc:        stable@freebsd.org, rmacklem@freebsd.org
Subject:   Re: 13-stable NFS server hang
Message-ID:  <CAM5tNy7ZZ2bVLmYnOCWzrS9wq6yudoV5JKG5ObRU0=wLt1ofZw@mail.gmail.com>
In-Reply-To: <26078.50375.679881.64018@hergotha.csail.mit.edu>
References:  <26078.50375.679881.64018@hergotha.csail.mit.edu>

next in thread | previous in thread | raw e-mail | index | archive | help
--000000000000613a6806127a02f4
Content-Type: text/plain; charset="UTF-8"
Content-Transfer-Encoding: quoted-printable

On Tue, Feb 27, 2024 at 9:30=E2=80=AFPM Garrett Wollman <wollman@bimajority=
.org> wrote:
>
> Hi, all,
>
> We've had some complaints of NFS hanging at unpredictable intervals.
> Our NFS servers are running a 13-stable from last December, and
> tonight I sat in front of the monitor watching `nfsstat -dW`.  I was
> able to clearly see that there were periods when NFS activity would
> drop *instantly* from 30,000 ops/s to flat zero, which would last
> for about 25 seconds before resuming exactly as it was before.
>
> I wrote a little awk script to watch for this happening and run
> `procstat -k` on the nfsd process, and I saw that all but two of the
> service threads were idle.  The three nfsd threads that had non-idle
> kstacks were:
>
>   PID    TID COMM                TDNAME              KSTACK
>   997 108481 nfsd                nfsd: master        mi_switch sleepq_tim=
edwait _sleep nfsv4_lock nfsrvd_dorpc nfssvc_program svc_run_internal svc_r=
un nfsrvd_nfsd nfssvc_nfsd sys_nfssvc amd64_syscall fast_syscall_common
>   997 960918 nfsd                nfsd: service       mi_switch sleepq_tim=
edwait _sleep nfsv4_lock nfsrv_setclient nfsrvd_exchangeid nfsrvd_dorpc nfs=
svc_program svc_run_internal svc_thread_start fork_exit fork_trampoline
>   997 962232 nfsd                nfsd: service       mi_switch _cv_wait t=
xg_wait_synced_impl txg_wait_synced dmu_offset_next zfs_holey zfs_freebsd_i=
octl vn_generic_copy_file_range vop_stdcopy_file_range VOP_COPY_FILE_RANGE =
vn_copy_file_range nfsrvd_copy_file_range nfsrvd_dorpc nfssvc_program svc_r=
un_internal svc_thread_start fork_exit fork_trampoline
>
> I'm suspicious of two things: first, the copy_file_range RPC; second,
> the "master" nfsd thread is actually servicing an RPC which requires
> obtaining a lock.  The "master" getting stuck while performing client
> RPCs is, I believe, the reason NFS service grinds to a halt when a
> client tries to write into a near-full filesystem, so this problem
> would be more evidence that the dispatching function should not be
> mixed with actual operations.  I don't know what the clients are
> doing, but is it possible that nfsrvd_copy_file_range is holding a
> lock that is needed by one or both of the other two threads?
>
> Near-term I could change nfsrvd_copy_file_range to just
> unconditionally return NFSERR_NOTSUP and force the clients to fall
> back, but I figured I would ask if anyone else has seen this.
I have attached a little patch that should limit the server's Copy size
to vfs.nfsd.maxcopyrange (default of 10Mbytes).
Hopefully this makes sure that the Copy does not take too long.

You could try this instead of disabling Copy. It would be nice to know if
this is suffciient? (If not, I'll probably add a sysctl to disable Copy.)

rick

>
> -GAWollman
>
>

--000000000000613a6806127a02f4
Content-Type: application/octet-stream; name="copylen.patch"
Content-Disposition: attachment; filename="copylen.patch"
Content-Transfer-Encoding: base64
Content-ID: <f_lt6gr9sk0>
X-Attachment-Id: f_lt6gr9sk0

LS0tIHN5cy9mcy9uZnNzZXJ2ZXIvbmZzX25mc2RzZXJ2LmMuY29weWxlbgkyMDI0LTAyLTI4IDE1
OjM1OjQ3LjcwMDUzMTAwMCAtMDgwMAorKysgc3lzL2ZzL25mc3NlcnZlci9uZnNfbmZzZHNlcnYu
YwkyMDI0LTAyLTI4IDE1OjQxOjMzLjcyMzAyMjAwMCAtMDgwMApAQCAtOTksNiArOTksOSBAQCBT
WVNDVExfQk9PTChfdmZzX25mc2QsIE9JRF9BVVRPLCBlbmFibGVfdjQyYWxsb2NhdGUsIEMKIFNZ
U0NUTF9CT09MKF92ZnNfbmZzZCwgT0lEX0FVVE8sIGVuYWJsZV92NDJhbGxvY2F0ZSwgQ1RMRkxB
R19SVywKICAgICAmbmZzcnZfZG9hbGxvY2F0ZSwgMCwKICAgICAiRW5hYmxlIE5GU3Y0LjIgQWxs
b2NhdGUgb3BlcmF0aW9uIik7CitzdGF0aWMgdWludDY0X3QgbmZzcnZfbWF4Y29weXJhbmdlID0g
MTAgKiAxMDI0ICogMTAyNDsKK1NZU0NUTF9VNjQoX3Zmc19uZnNkLCBPSURfQVVUTywgbWF4Y29w
eXJhbmdlLCBDVExGTEFHX1JXLAorICAgICZuZnNydl9tYXhjb3B5cmFuZ2UsIDAsICJNYXggc2l6
ZSBvZiBhIENvcHkgc28gUlBDIHRpbWVzIHJlYXNvbmFibGUiKTsKIAogLyoKICAqIFRoaXMgbGlz
dCBkZWZpbmVzIHRoZSBHU1MgbWVjaGFuaXNtcyBzdXBwb3J0ZWQuCkBAIC01Nzc4LDcgKzU3ODEs
MTUgQEAgbmZzcnZkX2NvcHlfZmlsZV9yYW5nZShzdHJ1Y3QgbmZzcnZfZGVzY3JpcHQgKm5kLCBf
X3VuCiAJCQluZC0+bmRfcmVwc3RhdCA9IGVycm9yOwogCX0KIAotCXhmZXIgPSBsZW47CisJLyoK
KwkgKiBEbyB0aGUgYWN0dWFsIGNvcHkgdG8gYW4gdXBwZXIgbGltaXQgb2YgdmZzLm5mc2QubWF4
Y29weXJhbmdlLgorCSAqIFRoaXMgbGltaXQgaXMgYXBwbGllZCB0byBlbnN1cmUgdGhhdCB0aGUg
UlBDIHJlcGxpZXMgaW4gYQorCSAqIHJlYXNvbmFibGUgdGltZS4KKwkgKi8KKwlpZiAobGVuID4g
bmZzcnZfbWF4Y29weXJhbmdlKQorCQl4ZmVyID0gbmZzcnZfbWF4Y29weXJhbmdlOworCWVsc2UK
KwkJeGZlciA9IGxlbjsKIAlpZiAobmQtPm5kX3JlcHN0YXQgPT0gMCkgewogCQluZC0+bmRfcmVw
c3RhdCA9IHZuX2NvcHlfZmlsZV9yYW5nZSh2cCwgJmlub2ZmLCB0b3ZwLCAmb3V0b2ZmLAogCQkg
ICAgJnhmZXIsIENPUFlfRklMRV9SQU5HRV9USU1FTzFTRUMsIG5kLT5uZF9jcmVkLCBuZC0+bmRf
Y3JlZCwK
--000000000000613a6806127a02f4--



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?CAM5tNy7ZZ2bVLmYnOCWzrS9wq6yudoV5JKG5ObRU0=wLt1ofZw>