[NFS-Ganesha-Support] bug in nfs-ganesha? and cephfs?

Sunday, 14 June 2020

When rsyncing to a nfs-ganesha exported cephfs the process hangs, and 
escalates into "cache pressure" of other cephfs clients[1].

When testing the rsync with more debugging on, I noticed that rsync 
stalled at the 'set modtime of . '[2]

After restarting the nfs-ganesha and doing a few successful ls -al on 
the nfs mount. I was able to create this 'stall' by doing only a 'touch 
/var/www/cobbler/ks_mirror/CentOS7-x86_64/' on the directory. As 
mentioned in the post[1]. The same xlock message is in the mds log[4] 
the nfs-ganesha log during this touch[5].

nfs-ganesha-2.8.1.2-0.1.el7.x86_64
nfs-ganesha-ceph-2.8.1.2-0.1.el7.x86_64

ceph version 14.2.9 (581f22da52345dba46ee232b73b990f06029a2a0) nautilus 
(stable)

[1]
https://www.mail-archive.com/ceph-users@ceph.io/msg04527.html

[2]
recv_file_name(Packages/zziplib-devel-0.13.62-12.el7.i686.rpm)
recv_file_name(Packages/zziplib-devel-0.13.62-12.el7.x86_64.rpm)
recv_file_name(Packages/zziplib-utils-0.13.62-12.el7.x86_64.rpm)
recv_file_name(Packages/centos-release-7-8.2003.0.el7.centos.x86_64.rpm)
recv_file_name(Packages/lorax-19.7.26-1.el7.centos.x86_64.rpm)
received 10070 names
recv_file_list done
recv_generator(.,0)
set modtime of . to (1587553127) Wed Apr 22 12:58:47 2020 

[3]
2020-06-14 14:36:26.133 7fb5edd82700  0 log_channel(cluster) log [WRN] : 
slow request 60.157532 seconds old, received at 2020-06-14 
14:35:25.977231: client_request(client.4022202:52 setattr 
mtime=2020-06-14 14:35:25.976975 atime
=2020-06-14 14:35:25.976974 #0x100001b9177 2020-06-14 14:35:25.977014 
caller_uid=500, caller_gid=500{500,1,2,3,4,6,10,}) currently failed to 
xlock, waiting
2020-06-14 14:36:26.133 7fb5edd82700  0 log_channel(cluster) log [WRN] : 
client.4022217 isn't responding to mclientcaps(revoke), ino 
0x100001b9177 pending pAsLsXs issued pAsLsXsFs, sent 60.158122 seconds 
ago

[4]
2020-06-14 14:35:56.133 7fb5edd82700  0 log_channel(cluster) log [WRN] : 
1 slow requests, 1 included below; oldest blocked for > 30.156793 secs
2020-06-14 14:35:56.133 7fb5edd82700  0 log_channel(cluster) log [WRN] : 
slow request 30.156792 seconds old, received at 2020-06-14 
14:35:25.977231: client_request(client.4022202:52 setattr 
mtime=2020-06-14 14:35:25.976975 atime
=2020-06-14 14:35:25.976974 #0x100001b9177 2020-06-14 14:35:25.977014 
caller_uid=500, caller_gid=500{500,1,2,3,4,6,10,}) currently failed to 
xlock, waiting

[5]
14/06/2020 14:35:23 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[reaper] 
reaper_run :CLIENT ID :DEBUG :Now checking NFS4 clients for expiration
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
alloc_nfs_request :DISP :DEBUG :0x7feb40000ce0 fd 166 context 
0x7feb14004b60
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.2 
for Program 100003, Version 4, Function 1 has xid=4153280463
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb14006c50, tag = NO TAG
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 22 is OP_PUTFH
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 10
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 16063
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0x7feb2c006d70 type: 7, New type: 7
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 0 = NFS4_OK, op 
response size is 4 total response size is 40
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 3 is OP_ACCESS
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_access_op :NFS3 :DEBUG :NFS3: DEBUG: Requested 
ACCESS=READ,LOOKUP,MODIFY,EXTEND,DELETE,-
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_access_op :NFS3 :DEBUG :NFS3: DEBUG: access_mask = mode(rwx) 
ACL(list_dir,add_file,execute,add_subdirectory,delete_child)
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_access_op :NFS3 :DEBUG :NFS3: DEBUG: Supported 
ACCESS=READ,LOOKUP,MODIFY,EXTEND,DELETE,-
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_access_op :NFS3 :DEBUG :NFS3: DEBUG: Granted 
ACCESS=READ,LOOKUP,MODIFY,EXTEND,DELETE,-
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_ACCESS in position 1 = NFS4_OK, 
op response size is 12 total response size is 56
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0x7feb2c006da8
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
encode_fsid :NFS4 :DEBUG :fsid.major = 4294967295, fsid.minor = 
4294967294
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 144 total response size is 204
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb40000ce0 fd 166 
(::ffff:192.168.10.2:736) xid=4153280463 returned XPRT_IDLE
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
alloc_nfs_request :DISP :DEBUG :0x7feb40000ce0 fd 166 context 
0x7feb4c005710
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.2 
for Program 100003, Version 4, Function 1 has xid=4170057679
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb4c0078c0, tag = NO TAG
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 22 is OP_PUTFH
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 10
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih AVL hit slot 21342
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa8dd60 type: 7, New type: 7
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 0 = NFS4_OK, op 
response size is 4 total response size is 40
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 34 is OP_SETATTR
14/06/2020 14:35:25 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_3] 
fsal_check_setattr_perms :FSAL :DEBUG :Access check returned No error 
(Ok for owner)
14/06/2020 14:35:33 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[reaper] 
reaper_run :CLIENT ID :DEBUG :Now checking NFS4 clients for expiration
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb18004c80
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4045722888
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb18003de0, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 30
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih AVL hit slot 11701
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91800 type: 7, New type: 7
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91838
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
encode_fsid :NFS4 :DEBUG :fsid.major = 4294967295, fsid.minor = 
4294967294
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 144 total response size is 232
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4045722888 returned XPRT_IDLE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb24005ba0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4062500104
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb24007110, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 35
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih AVL hit slot 11885
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91c70 type: 7, New type: 7
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91ca8
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
encode_fsid :NFS4 :DEBUG :fsid.major = 4294967295, fsid.minor = 
4294967294
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 144 total response size is 232
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4062500104 returned XPRT_IDLE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb14004b60
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4079277320
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb14007e30, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 30
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11701
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91800 type: 7, New type: 7
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91838
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4079277320 returned XPRT_IDLE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb5800c180
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4096054536
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb5800bdb0, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 35
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11885
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91c70 type: 7, New type: 7
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91ca8
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4096054536 returned XPRT_IDLE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
alloc_nfs_request :DISP :DEBUG :0x7feb4c001060 fd 161 context 
0x7feb40003150
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.153 
for Program 100003, Version 4, Function 1 has xid=225276012
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb40006d40, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb38003da0
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb4c001060 fd 161 
(::ffff:192.168.10.153:920) xid=225276012 returned XPRT_IDLE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
alloc_nfs_request :DISP :DEBUG :0x7feb48000c90 fd 160 context 
0x7feb1c005c50
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.151 
for Program 100003, Version 4, Function 1 has xid=937363790
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb1c006d40, tag = NO TAG
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb50002630
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:34 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb48000c90 fd 160 
(::ffff:192.168.10.151:998) xid=937363790 returned XPRT_IDLE
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb48005240
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4112831752
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb4800a860, tag = NO TAG
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 30
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11701
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91800 type: 7, New type: 7
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91838
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4112831752 returned XPRT_IDLE
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb34006230
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4129608968
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb34005270, tag = NO TAG
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 35
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11885
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91c70 type: 7, New type: 7
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91ca8
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:35 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4129608968 returned XPRT_IDLE
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb2c0044d0
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4146386184
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb2c006120, tag = NO TAG
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 30
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11701
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91800 type: 7, New type: 7
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91838
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4146386184 returned XPRT_IDLE
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb18004b90
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4163163400
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb18003de0, tag = NO TAG
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 35
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11885
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91c70 type: 7, New type: 7
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91ca8
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:36 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_16] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4163163400 returned XPRT_IDLE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb24005ba0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4179940616
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb24007110, tag = NO TAG
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 30
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11701
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91800 type: 7, New type: 7
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91838
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_13] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4179940616 returned XPRT_IDLE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
alloc_nfs_request :DISP :DEBUG :0x7feb44001060 fd 162 context 
0x7feb14004b60
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_client :HT CACHE :DEBUG :client_mgr cache hit slot 0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.113 
for Program 100003, Version 4, Function 1 has xid=4196717832
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 
0x7feb14007e30, tag = NO TAG
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb340023d0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
get_gsh_export :HT CACHE :DEBUG :export_mgr cache hit slot 35
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :fdcache MISS
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
cih_get_by_key_latch :HT CACHE :DEBUG :cih cache hit slot 11885
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
mdcache_new_entry :INODE :DEBUG :Trying to add an already existing 
entry. Found entry 0xa91c70 type: 7, New type: 7
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op 
response size is 4 total response size is 84
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
file_To_Fattr :NFS4 ACL :DEBUG :No permission check for ACL for obj 
0xa91ca8
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, 
op response size is 52 total response size is 140
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_14] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb44001060 fd 162 
(::ffff:192.168.10.113:967) xid=4196717832 returned XPRT_IDLE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
alloc_nfs_request :DISP :DEBUG :0x7feb400008c0 fd 164 context 
0x7feb5800bdb0
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.152 
for Program 100003, Version 4, Function 1 has xid=1500681607
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb5800c180, tag = NO TAG
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb34006410
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_2] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb400008c0 fd 164 
(::ffff:192.168.10.152:747) xid=1500681607 returned XPRT_IDLE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
alloc_nfs_request :DISP :DEBUG :0x7feb4c003690 fd 165 context 
0x7feb40003150
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.111 
for Program 100003, Version 4, Function 1 has xid=1915990987
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb40002f50, tag = NO TAG
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb48006360
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:37 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_24] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb4c003690 fd 165 
(::ffff:192.168.10.111:977) xid=1915990987 returned XPRT_IDLE
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
alloc_nfs_request :DISP :DEBUG :0x7feb58000c90 fd 152 context 
0x7feb1c005c50
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.103 
for Program 100003, Version 4, Function 1 has xid=113039167
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb1c006d40, tag = NO TAG
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 30 is OP_RENEW
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
complete_op :NFS4 :DEBUG :Status of OP_RENEW in position 0 = NFS4_OK, op 
response size is 4 total response size is 40
14/06/2020 14:35:39 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_15] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb58000c90 fd 152 
(::ffff:192.168.10.103:945) xid=113039167 returned XPRT_IDLE
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
alloc_nfs_request :DISP :DEBUG :0x7feb2c000c90 fd 159 context 
0x7feb48005240
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.114 
for Program 100003, Version 4, Function 1 has xid=3613830069
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb4800a860, tag = NO TAG
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb2c002070
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_23] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb2c000c90 fd 159 
(::ffff:192.168.10.114:687) xid=3613830069 returned XPRT_IDLE
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
alloc_nfs_request :DISP :DEBUG :0x7feb140008c0 fd 163 context 
0x7feb34006230
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.112 
for Program 100003, Version 4, Function 1 has xid=3310701715
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb34005270, tag = NO TAG
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
nfs4_op_sequence :SESSIONS :DEBUG :SEQUENCE session=0x7feb480022f0
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, 
op response size is 40 total response size is 76
14/06/2020 14:35:40 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_18] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb140008c0 fd 163 
(::ffff:192.168.10.112:729) xid=3310701715 returned XPRT_IDLE
14/06/2020 14:35:43 : epoch 5ee617d5 : c01 : 
ganesha.nfsd-481476[chunk_lru] chunk_lru_run :INODE LRU :DEBUG :After 
work, threadwait=90 totalwork=0
14/06/2020 14:35:43 : epoch 5ee617d5 : c01 : 
ganesha.nfsd-481476[cache_lru] lru_run :INODE LRU :DEBUG :FD count is 0 
and low water mark is 2048: not reaping.
14/06/2020 14:35:43 : epoch 5ee617d5 : c01 : 
ganesha.nfsd-481476[cache_lru] lru_run :INODE LRU :DEBUG :After work, 
open_fd_count:0  count:41 fdrate:1 new_thread_wait=90
14/06/2020 14:35:43 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[reaper] 
reaper_run :CLIENT ID :DEBUG :Now checking NFS4 clients for expiration
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
alloc_nfs_request :DISP :DEBUG :0x7feb40000ce0 fd 166 context 
0x7feb2c0044d0
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
nfs_rpc_process_request :DISP :DEBUG :Request from ::ffff:192.168.10.2 
for Program 100003, Version 4, Function 1 has xid=4186834895
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
dupreq_tcp_cmpf :DUPREQ :DEBUG :dupreq_tcp_cmpf
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 
0x7feb2c006120, tag = NO TAG
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
process_one_op :NFS4 :DEBUG :Request 0: opcode 30 is OP_RENEW
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
complete_op :NFS4 :DEBUG :Status of OP_RENEW in position 0 = NFS4_OK, op 
response size is 4 total response size is 40
14/06/2020 14:35:45 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[svc_25] 
free_nfs_request :DISP :DEBUG :SVC_DECODE on 0x7feb40000ce0 fd 166 
(::ffff:192.168.10.2:736) xid=4186834895 returned XPRT_IDLE
14/06/2020 14:35:53 : epoch 5ee617d5 : c01 : ganesha.nfsd-481476[reaper] 
reaper_run :CLIENT ID :DEBUG :Now checking NFS4 clients for expiration

2024

2023

2022

2021

2020

2019

2018

[NFS-Ganesha-Support] bug in nfs-ganesha? and cephfs?