Package: nfs-ganesha Version: 4.3-2 Severity: normal Dear Maintainer, *** Reporter, please consider answering these questions, where appropriate *** * What led up to the situation? I'm trying to migrate my servers with nfs-kernel-server to nfs-ganesha * What exactly did you do (or not do) that was effective (or ineffective)? It is a new installation * What was the outcome of this action? * What outcome did you expect instead? It is a privileged lxc container that runs on top of proxmox *** End of the template - remove these template lines *** -- System Information: Debian Release: 12.0 APT prefers testing-security APT policy: (500, 'testing-security'), (500, 'testing') Architecture: amd64 (x86_64) Kernel: Linux 5.15.74-1-pve (SMP w/1 CPU thread) Kernel taint flags: TAINT_PROPRIETARY_MODULE, TAINT_OOT_MODULE Locale: LANG=ca_ES.UTF-8, LC_CTYPE=ca_ES.UTF-8 (charmap=UTF-8) (ignored: LC_ALL set to ca_ES.UTF-8), LANGUAGE=ca_ES.UTF-8 Shell: /bin/sh linked to /usr/bin/dash Init: systemd (via /run/systemd/system) Versions of packages nfs-ganesha depends on: ii dbus 1.14.6-1 ii libacl1 2.3.1-3 ii libblkid1 2.38.1-5+b1 ii libc6 2.36-9 ii libcap2 1:2.66-4 ii libcom-err2 1.47.0-2 ii libdbus-1-3 1.14.6-1 ii libgssapi-krb5-2 1.20.1-2 ii libkrb5-3 1.20.1-2 ii libnfsidmap1 1:2.6.2-4 ii libntirpc4.3 4.3-2 ii liburcu8 0.13.2-1 ii libuuid1 2.38.1-5+b1 ii libwbclient0 2:4.17.8+dfsg-2 ii nfs-common 1:2.6.2-4 ii rpcbind 1.2.6-6+b1 nfs-ganesha recommends no packages. nfs-ganesha suggests no packages. -- Configuration Files: /etc/ganesha/ganesha.conf changed: LOG { COMPONENTS { NFS4 = FULL_DEBUG; IDMAPPER = Full_Debug; } } EXPORT { Export_Id = 1 ; Path = "/srv/PVE" ; Pseudo = "/srv/PVE"; protocols = 3,4 ; # Error protocols = "3,4" ; #SecType = "sys"; #SecType = sys, krb5; squash = none; access_type = rw; FSAL { name = VFS; } } -- no debconf information ############## # NFS Client # ############## root@et089601:~# mount | grep template-mount 172.20.10.107:/srv/PVE on /tmp/template-mount type nfs4 (rw,relatime,vers=4.2,rsize=1048576,wsize=1048576,namlen=255,hard,proto=tcp,timeo=600,retrans=2,sec=sys,clientaddr=172.20.11.39,local_lock=none,addr=172.20.10.107) root@et089601:~# ls/tmp/template-mount/ ls: cannot access '/tmp/template-mount/': Operation not permitted ############## # NFS server # ############## 12.0 root@template-server:/home/mgual# cat /var/log/ganesha/ganesha.log 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2904[main] init_logging :LOG :NULL :LOG: Setting log level for all components to NIV_EVENT 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2904[main] main :MAIN :EVENT :ganesha.nfsd Starting: Ganesha Version 4.3 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] load_rados_config :CONFIG :WARN :Missing RADOS URLs backend library 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] SetComponentLogLevel :LOG :NULL :LOG: Changing log level of COMPONENT_NFS_V4 from NIV_EVENT to NIV_FULL_DEBUG 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] SetComponentLogLevel :LOG :NULL :LOG: Changing log level of COMPONENT_IDMAPPER from NIV_EVENT to NIV_FULL_DEBUG 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_set_param_from_conf :NFS STARTUP :EVENT :Configuration file successfully parsed 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] init_fds_limit :INODE LRU :EVENT :Setting the system-imposed limit on FDs to 524288. 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] init_server_pkgs :NFS STARTUP :EVENT :Initializing ID Mapper. 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] init_server_pkgs :NFS STARTUP :EVENT :ID Mapper successfully initialized. 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_start_grace :STATE :EVENT :NFS Server Now IN GRACE, duration 90 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_start_grace :STATE :EVENT :grace reload client info completed from backend 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_try_lift_grace :STATE :EVENT :check grace:reclaim complete(0) clid count(1) 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] lower_my_caps :NFS STARTUP :EVENT :CAP_SYS_RESOURCE was successfully removed for proper quota management in FSAL 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] lower_my_caps :NFS STARTUP :EVENT :currently set capabilities are: =ep cap_sys_module,cap_sys_rawio,cap_sys_resource,cap_sys_time,cap_mac_override,cap_mac_admin-ep 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Init_svc :DISP :CRIT :Cannot acquire credentials for principal nfs 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Init_admin_thread :NFS CB :EVENT :Admin thread initialized 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_rpc_cb_init_ccache :NFS STARTUP :EVENT :Callback creds directory (/var/run/ganesha) already exists 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] find_keytab_entry :NFS CB :WARN :Configuration file does not specify default realm while getting default realm name 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] gssd_refresh_krb5_machine_credential :NFS CB :CRIT :ERROR: gssd_refresh_krb5_machine_credential: no usable keytab entry found in keytab /etc/krb5.keytab for connection with host localhost 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_rpc_cb_init_ccache :NFS STARTUP :WARN :gssd_refresh_krb5_machine_credential failed (-1765328160:2) 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Start_threads :THREAD :EVENT :Starting delayed executor. 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Start_threads :THREAD :EVENT :gsh_dbusthread was started successfully 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Start_threads :THREAD :EVENT :admin thread was started successfully 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Start_threads :THREAD :EVENT :reaper thread was started successfully 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_Start_threads :THREAD :EVENT :General fridge was started successfully 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_start :NFS STARTUP :EVENT :------------------------------------------------- 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_start :NFS STARTUP :EVENT : NFS SERVER INITIALIZED 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[main] nfs_start :NFS STARTUP :EVENT :------------------------------------------------- 07/06/2023 13:37:05 : epoch 64806be1 : template-server : ganesha.nfsd-2905[reaper] nfs_try_lift_grace :STATE :EVENT :check grace:reclaim complete(0) clid count(1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc014001930, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {SEQUENCE} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4ERR_BADSESSION, op response size is 4 total response size is 40 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] complete_nfs4_compound :NFS4 :DEBUG :End status = NFS4ERR_BADSESSION lastindex = 1 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_198] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc014001b80 (resarraylen=1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc018001750, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {DESTROY_SESSION} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 44 is OP_DESTROY_SESSION 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_DESTROY_SESSION in position 0 = NFS4ERR_BADSESSION, op response size is 4 total response size is 40 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_nfs4_compound :NFS4 :DEBUG :End status = NFS4ERR_BADSESSION lastindex = 1 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc0180019a0 (resarraylen=1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc0180011b0, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {CREATE_SESSION} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 43 is OP_CREATE_SESSION 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_CREATE_SESSION in position 0 = NFS4ERR_STALE_CLIENTID, op response size is 4 total response size is 40 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_nfs4_compound :NFS4 :DEBUG :End status = NFS4ERR_STALE_CLIENTID lastindex = 1 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018001400 (resarraylen=1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc018002230, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {EXCHANGE_ID} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 42 is OP_EXCHANGE_ID 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_EXCHANGE_ID in position 0 = NFS4_OK, op response size is 0 total response size is 36 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018002480 (resarraylen=1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc018002be0, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {CREATE_SESSION} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 43 is OP_CREATE_SESSION 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_CREATE_SESSION in position 0 = NFS4_OK, op response size is 112 total response size is 148 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018002e30 (resarraylen=1) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 0x7fc01800d3d0, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 3 operations nfs4 operations {SEQUENCE, PUTROOTFH, GETATTR} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 24 is OP_PUTROOTFH 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_PUTROOTFH in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_export_check_access :NFS4 :M_DBG :about to call export_check_access 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_op_putrootfh :NFS4 :F_DBG :NFS4 PUTROOTFH CURRENT FH: File Handle V4: Len=128 0x430000007bcc39462664c9fac301002f00000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=128 0x70d90018c07f000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000200000000000000b84fab3d9e550000000000000000000000000000000000000000000000000000070000000000000000000000000000000000000000000000 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_PUTROOTFH in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :M_DBG :Check export perms export = 00000080 req = 00000080 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 0 total response size would be = 96 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 10, name = FATTR4_LEASE_TIME 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Maximum allowed attr index = 82 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 10, name = FATTR4_LEASE_TIME, pos = 4 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 8 total response size would be = 104 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=128 0x70d90018c07f000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000200000000000000b84fab3d9e550000000000000000000000000000000000000000000000000000070000000000000000000000000000000000000000000000 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, op response size is 8 total response size is 96 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018003160 (resarraylen=3) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 2 operations, res = 0x7fc01800e250, tag = NO TAG 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 2 operations nfs4 operations {SEQUENCE, RECLAIM_COMPLETE} 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 58 is OP_RECLAIM_COMPLETE 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_RECLAIM_COMPLETE in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_RECLAIM_COMPLETE in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:10 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018002a70 (resarraylen=2) 07/06/2023 13:37:15 : epoch 64806be1 : template-server : ganesha.nfsd-2905[reaper] nfs_try_lift_grace :STATE :EVENT :check grace:reclaim complete(1) clid count(1) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 0x7fc01800eab0, tag = NO TAG 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 3 operations nfs4 operations {SEQUENCE, PUTFH, GETATTR} 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_PUTFH in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_export_check_access :NFS4 :M_DBG :about to call export_check_access 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x80d10018c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :M_DBG :Check export perms export = 000001e0 req = 00000080 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 0 total response size would be = 96 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 1, name = FATTR4_TYPE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 3, name = FATTR4_CHANGE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 4, name = FATTR4_SIZE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 8, name = FATTR4_FSID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 20, name = FATTR4_FILEID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 33, name = FATTR4_MODE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 35, name = FATTR4_NUMLINKS 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 36, name = FATTR4_OWNER 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 37, name = FATTR4_OWNER_GROUP 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 41, name = FATTR4_RAWDEV 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 45, name = FATTR4_SPACE_USED 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 47, name = FATTR4_TIME_ACCESS 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 52, name = FATTR4_TIME_METADATA 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 53, name = FATTR4_TIME_MODIFY 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 55, name = FATTR4_MOUNTED_ON_FILEID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Maximum allowed attr index = 82 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 1, name = FATTR4_TYPE, pos = 4 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 3, name = FATTR4_CHANGE, pos = 12 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 4, name = FATTR4_SIZE, pos = 20 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] encode_fsid :NFS4 :DEBUG :fsid.major = 1812786454, fsid.minor = 2719743774 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 8, name = FATTR4_FSID, pos = 36 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 20, name = FATTR4_FILEID, pos = 44 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 33, name = FATTR4_MODE, pos = 48 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 35, name = FATTR4_NUMLINKS, pos = 52 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 36, name = FATTR4_OWNER, pos = 64 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 37, name = FATTR4_OWNER_GROUP, pos = 76 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 41, name = FATTR4_RAWDEV, pos = 84 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 45, name = FATTR4_SPACE_USED, pos = 92 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 47, name = FATTR4_TIME_ACCESS, pos = 104 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 52, name = FATTR4_TIME_METADATA, pos = 116 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 53, name = FATTR4_TIME_MODIFY, pos = 128 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 55, name = FATTR4_MOUNTED_ON_FILEID, pos = 136 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 140 total response size would be = 236 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x80d10018c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, op response size is 140 total response size is 228 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc018002ab0 (resarraylen=3) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 0x7fc01800fb40, tag = NO TAG 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 3 operations nfs4 operations {SEQUENCE, PUTFH, GETATTR} 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_PUTFH in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_export_check_access :NFS4 :M_DBG :about to call export_check_access 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0xe0000118c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :M_DBG :Check export perms export = 000001e0 req = 00000080 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 0 total response size would be = 96 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 1, name = FATTR4_TYPE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 3, name = FATTR4_CHANGE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 4, name = FATTR4_SIZE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 8, name = FATTR4_FSID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 20, name = FATTR4_FILEID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 33, name = FATTR4_MODE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 35, name = FATTR4_NUMLINKS 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 36, name = FATTR4_OWNER 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 37, name = FATTR4_OWNER_GROUP 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 41, name = FATTR4_RAWDEV 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 45, name = FATTR4_SPACE_USED 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 47, name = FATTR4_TIME_ACCESS 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 52, name = FATTR4_TIME_METADATA 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 53, name = FATTR4_TIME_MODIFY 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 55, name = FATTR4_MOUNTED_ON_FILEID 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Maximum allowed attr index = 82 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 1, name = FATTR4_TYPE, pos = 4 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 3, name = FATTR4_CHANGE, pos = 12 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 4, name = FATTR4_SIZE, pos = 20 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] encode_fsid :NFS4 :DEBUG :fsid.major = 1812786454, fsid.minor = 2719743774 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 8, name = FATTR4_FSID, pos = 36 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 20, name = FATTR4_FILEID, pos = 44 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 33, name = FATTR4_MODE, pos = 48 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 35, name = FATTR4_NUMLINKS, pos = 52 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 36, name = FATTR4_OWNER, pos = 64 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 37, name = FATTR4_OWNER_GROUP, pos = 76 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 41, name = FATTR4_RAWDEV, pos = 84 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 45, name = FATTR4_SPACE_USED, pos = 92 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 47, name = FATTR4_TIME_ACCESS, pos = 104 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 52, name = FATTR4_TIME_METADATA, pos = 116 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 53, name = FATTR4_TIME_MODIFY, pos = 128 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 55, name = FATTR4_MOUNTED_ON_FILEID, pos = 136 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 140 total response size would be = 236 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0xe0000118c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, op response size is 140 total response size is 228 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800d970 (resarraylen=3) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 0x7fc0180102c0, tag = NO TAG 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 3 operations nfs4 operations {SEQUENCE, PUTFH, READDIR} 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_PUTFH in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_export_check_access :NFS4 :M_DBG :about to call export_check_access 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x70d90018c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 2: opcode 26 is OP_READDIR 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :M_DBG :Check export perms export = 000001e0 req = 00000080 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_READDIR in position 2 is ok so far, op response size = 0 total response size would be = 96 out of max 1049480/7584 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x70d90018c07f0000000000000000000000000000000000 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_READDIR in position 2 = NFS4ERR_PERM, op response size is 4 total response size is 92 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_nfs4_compound :NFS4 :DEBUG :End status = NFS4ERR_PERM lastindex = 3 07/06/2023 13:37:22 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800d180 (resarraylen=3) 07/06/2023 13:37:25 : epoch 64806be1 : template-server : ganesha.nfsd-2905[reaper] nfs_try_lift_grace :STATE :EVENT :check grace:reclaim complete(1) clid count(1) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 3 operations, res = 0x7fc018010850, tag = NO TAG 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 3 operations nfs4 operations {SEQUENCE, PUTFH, GETATTR} 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 53 is OP_SEQUENCE 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_SEQUENCE in position 0 is ok so far, op response size = 40 total response size would be = 84 out of max 1049480/7584 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_SEQUENCE in position 0 = NFS4_OK, op response size is 40 total response size is 76 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 1: opcode 22 is OP_PUTFH 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_PUTFH in position 1 is ok so far, op response size = 4 total response size would be = 92 out of max 1049480/7584 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_export_check_access :NFS4 :M_DBG :about to call export_check_access 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x80d10018c07f0000000000000000000000000000000000 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_PUTFH in position 1 = NFS4_OK, op response size is 4 total response size is 84 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 2: opcode 9 is OP_GETATTR 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :M_DBG :Check export perms export = 000001e0 req = 00000080 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 0 total response size would be = 96 out of max 1049480/7584 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 1, name = FATTR4_TYPE 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 3, name = FATTR4_CHANGE 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 4, name = FATTR4_SIZE 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 8, name = FATTR4_FSID 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 20, name = FATTR4_FILEID 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 33, name = FATTR4_MODE 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 35, name = FATTR4_NUMLINKS 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 36, name = FATTR4_OWNER 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 37, name = FATTR4_OWNER_GROUP 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 41, name = FATTR4_RAWDEV 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 45, name = FATTR4_SPACE_USED 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 47, name = FATTR4_TIME_ACCESS 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 52, name = FATTR4_TIME_METADATA 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 53, name = FATTR4_TIME_MODIFY 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] bitmap4_to_attrmask_t :NFS4 :F_DBG :Request attr 55, name = FATTR4_MOUNTED_ON_FILEID 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Maximum allowed attr index = 82 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 1, name = FATTR4_TYPE, pos = 4 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 3, name = FATTR4_CHANGE, pos = 12 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 4, name = FATTR4_SIZE, pos = 20 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] encode_fsid :NFS4 :DEBUG :fsid.major = 1812786454, fsid.minor = 2719743774 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 8, name = FATTR4_FSID, pos = 36 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 20, name = FATTR4_FILEID, pos = 44 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 33, name = FATTR4_MODE, pos = 48 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 35, name = FATTR4_NUMLINKS, pos = 52 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 36, name = FATTR4_OWNER, pos = 64 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 37, name = FATTR4_OWNER_GROUP, pos = 76 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 41, name = FATTR4_RAWDEV, pos = 84 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 45, name = FATTR4_SPACE_USED, pos = 92 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 47, name = FATTR4_TIME_ACCESS, pos = 104 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 52, name = FATTR4_TIME_METADATA, pos = 116 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 53, name = FATTR4_TIME_MODIFY, pos = 128 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] xdr_fattr4_encode :NFS4 :F_DBG :Encoded attr 55, name = FATTR4_MOUNTED_ON_FILEID, pos = 136 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] check_resp_room :NFS4 :F_DBG :Status of OP_GETATTR in position 2 is ok so far, op response size = 140 total response size would be = 236 out of max 1049480/7584 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=23 0x80d10018c07f0000000000000000000000000000000000 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_GETATTR in position 2 = NFS4_OK, op response size is 140 total response size is 228 07/06/2023 13:37:30 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc0180100e0 (resarraylen=3) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc018010850, tag = NO TAG 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {DESTROY_SESSION} 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 44 is OP_DESTROY_SESSION 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=2) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_DESTROY_SESSION in position 0 = NFS4_OK, op response size is 4 total response size is 40 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800fda0 (resarraylen=1) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :DEBUG :COMPOUND: There are 1 operations, res = 0x7fc018010850, tag = NO TAG 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] nfs4_Compound :NFS4 :F_DBG :COMPOUND: There are 1 operations nfs4 operations {DESTROY_CLIENTID} 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] process_one_op :NFS4 :DEBUG :Request 0: opcode 57 is OP_DESTROY_CLIENTID 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Current FH Len=0 (EMPTY) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :F_DBG :Saved FH Len=0 (EMPTY) 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] complete_op :NFS4 :DEBUG :Status of OP_DESTROY_CLIENTID in position 0 = NFS4_OK, op response size is 4 total response size is 40 07/06/2023 13:37:31 : epoch 64806be1 : template-server : ganesha.nfsd-2905[svc_197] release_nfs4_res_compound :NFS4 :F_DBG :Compound Free 0x7fc01800df90 (resarraylen=1) 07/06/2023 13:37:35 : epoch 64806be1 : template-server : ganesha.nfsd-2905[reaper] nfs_try_lift_grace :STATE :EVENT :check grace:reclaim complete(1) clid count(1)