autofs failing on first attempt; SIGINTed; success on second attempt; extra mount debugging

01_mount_config

testsftp -fstype=fuse,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key :sshfs\#redacteduser@redactedhost\:/export/home/files

console_a

[MYDOM\ME@MYHOST ~]$ date; time ls -ald /mnt/non-co/client_a/testsftp/*YUMA*
Thu Mar 23 09:22:40 CDT 2017
^C
[MYDOM\ME@MYHOST ~]$ date; time ls -ald /mnt/non-co/client_a/testsftp/*YUMA*
Thu Mar 23 09:23:29 CDT 2017
-rw-rw-r--. 1 railo railo 371989 Feb 13 11:00 /mnt/non-co/client_a/testsftp/CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170213.pdf
-rw-r-----. 1 railo railo 371989 Mar  1 08:20 /mnt/non-co/client_a/testsftp/CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170301.pdf
-rw-r-----. 1 railo railo  67881 Feb 28 23:12 /mnt/non-co/client_a/testsftp/CPD_Funding_Grantee_Matrix_YUMA-AZ_AZ_20170301.pdf

real	0m30.356s
user	0m0.029s
sys	0m0.004s
[MYDOM\ME@MYHOST ~]$

console_b

[MYDOM\ME@MYHOST ~]$ date; sudo automount -f -v
Thu Mar 23 09:22:37 CDT 2017
Starting automounter version 5.0.5-123.el6_8, master map auto.master
using kernel protocol version 5.02
lookup_read_master: lookup(nisplus): couldn't locate nis+ table auto.master
lookup(file): failed to read included master map auto.master
mounted indirect on /misc with timeout 300, freq 75 seconds
mounted indirect on /net with timeout 300, freq 75 seconds
master_do_mount: mounting /mnt/non-co/client_a
automount_path_to_fifo: fifo name /var/run/autofs.fifo-mnt-non-icf-client_a
lookup_nss_read_map: reading map file /etc/auto.client_a_sshfs
mounted indirect on /mnt/non-co/client_a with timeout 30, freq 8 seconds
st_ready: st_ready(): state = 0 path /mnt/non-co/client_a
ghosting enabled
handle_packet: type = 3
handle_packet_missing_indirect: token 140, name testsftp, request pid 6252
attempting to mount entry /mnt/non-co/client_a/testsftp
lookup_mount: lookup(file): looking up testsftp
lookup_mount: lookup(file): testsftp -> -fstype=fuse,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key :sshfs\#redacteduser@redactedhost\:/export/home/files
parse_mount: parse(sun): expanded entry: -fstype=fuse,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key :sshfs\#redacteduser@redactedhost\:/export/home/files
parse_mount: parse(sun): gathered options: uid=492,gid=488,fstype=fuse,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key
parse_mount: parse(sun): dequote(":sshfs\#redacteduser@redactedhost\:/export/home/files") -> :sshfs#redacteduser@redactedhost:/export/home/files
parse_mount: parse(sun): core of entry: options=uid=492,gid=488,fstype=fuse,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key, loc=:sshfs#redacteduser@redactedhost:/export/home/files
sun_mount: parse(sun): mounting root /mnt/non-co/client_a, mountpoint testsftp, what sshfs#redacteduser@redactedhost:/export/home/files, fstype fuse, options uid=492,gid=488,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key
do_mount: sshfs#redacteduser@redactedhost:/export/home/files /mnt/non-co/client_a/testsftp type fuse options uid=492,gid=488,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key using module generic
mount_mount: mount(generic): calling mkdir_path /mnt/non-co/client_a/testsftp
mount_mount: mount(generic): calling mount -t fuse -s -o uid=492,gid=488,rw,nodev,noatime,allow_other,debug,sshfs_debug,loglevel=debug,IdentityFile=/root/.ssh/client_a_sftp_key sshfs#redacteduser@redactedhost:/export/home/files /mnt/non-co/client_a/testsftp
>> SSHFS version 2.4
>> FUSE library version: 2.8.3
>> nullpath_ok: 0
>> executing <ssh> <-x> <-a> <-oClearAllForwardings=yes> <-ologlevel=debug> <-oIdentityFile=/root/.ssh/client_a_sftp_key> <-2> <redacteduser@redactedhost> <-s> <sftp>
>> debug1: Reading configuration data /etc/ssh/ssh_config
>> debug1: Applying options for *
>> debug1: Connecting to redactedhost [170.97.67.176] port 22.
>> debug1: Connection established.
>> debug1: permanently_set_uid: 0/0
>> debug1: identity file /root/.ssh/client_a_sftp_key type 2
>> debug1: identity file /root/.ssh/client_a_sftp_key-cert type -1
>> debug1: Remote protocol version 2.0, remote software version OpenSSH_5.3
>> debug1: match: OpenSSH_5.3 pat OpenSSH*
>> debug1: Enabling compatibility mode for protocol 2.0
>> debug1: Local version string SSH-2.0-OpenSSH_5.3
>> debug1: SSH2_MSG_KEXINIT sent
>> debug1: SSH2_MSG_KEXINIT received
>> debug1: kex: server->client aes128-ctr hmac-sha1 none
>> debug1: kex: client->server aes128-ctr hmac-sha1 none
>> debug1: SSH2_MSG_KEX_DH_GEX_REQUEST(1024<2048<8192) sent
>> debug1: expecting SSH2_MSG_KEX_DH_GEX_GROUP
>> debug1: SSH2_MSG_KEX_DH_GEX_INIT sent
>> debug1: expecting SSH2_MSG_KEX_DH_GEX_REPLY
>> debug1: Host 'redactedhost' is known and matches the RSA host key.
>> debug1: Found key in /root/.ssh/known_hosts:12
>> debug1: ssh_rsa_verify: signature correct
>> debug1: SSH2_MSG_NEWKEYS sent
>> debug1: expecting SSH2_MSG_NEWKEYS
>> debug1: SSH2_MSG_NEWKEYS received
>> debug1: SSH2_MSG_SERVICE_REQUEST sent
>> debug1: SSH2_MSG_SERVICE_ACCEPT received
>> This system is for the use of authorized users only
>> Individuals using this computer system without authority,
>> or in excess of their authority, are subject to having all
>> of their activities on this system monitored and recorded
>> by system personnel.
>> In the course of monitoring individuals improperly using
>> this system, or in the course of system maintenance, the
>> activities of authorized users may also be monitored.
>> Anyone using this system expressly consents to such
>> monitoring and is advised that if such monitoring reveals
>> possible evidence of criminal activity, system personnel
>> may provide the evidence of such monitoring to law
>> enforcement officials.
>> 32016
>> debug1: Authentications that can continue: publickey,gssapi-keyex,gssapi-with-mic,password
>> debug1: Next authentication method: gssapi-keyex
>> debug1: No valid Key exchange context
>> debug1: Next authentication method: gssapi-with-mic
>> debug1: Unspecified GSS failure.  Minor code may provide more information
>> Credentials cache file '/tmp/krb5cc_0' not found
>>
>> debug1: Unspecified GSS failure.  Minor code may provide more information
>> Credentials cache file '/tmp/krb5cc_0' not found
>>
>> debug1: Unspecified GSS failure.  Minor code may provide more information
>>
>> debug1: Unspecified GSS failure.  Minor code may provide more information
>> Credentials cache file '/tmp/krb5cc_0' not found
>>
>> debug1: Next authentication method: publickey
>> debug1: Offering public key: /root/.ssh/client_a_sftp_key
>> debug1: Server accepts key: pkalg ssh-dss blen 435
>> debug1: read PEM private key done: type DSA
>> debug1: Authentication succeeded (publickey).
>> debug1: channel 0: new [client-session]
>> debug1: Requesting no-more-sessions@openssh.com
>> debug1: Entering interactive session.
>> debug1: Sending environment.
>> debug1: Sending env LANG = en_US.UTF-8
>> debug1: Sending subsystem: sftp
>> Server version: 3
>> Extension: posix-rename@openssh.com <1>
>> Extension: statvfs@openssh.com <2>
>> Extension: fstatvfs@openssh.com <2>
>> unique: 1, opcode: INIT (26), nodeid: 0, insize: 56
>> INIT: 7.14
>> flags=0x0000f07b
>> max_readahead=0x00020000
>>    INIT: 7.12
>>    flags=0x00000011
>>    max_readahead=0x00020000
>>    max_write=0x00020000
>>    unique: 1, success, outsize: 40
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a


###### This is the point at which I SIGINTed the first access attempt and tried again. ######

>> unique: 2, opcode: OPENDIR (27), nodeid: 1, insize: 48
>>    unique: 2, success, outsize: 32
>> unique: 3, opcode: READDIR (28), nodeid: 1, insize: 80
>> getdir[0]
>> [00001] OPENDIR
>>   [00001]         HANDLE       17bytes (161ms)
>> [00002] READDIR
>>   [00002]           NAME    19215bytes (2888ms)
>> [00003] READDIR
>>   [00003]           NAME    19389bytes (2806ms)
>> [00004] READDIR
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
>>   [00004]           NAME    19421bytes (2814ms)
>> [00005] READDIR
>>   [00005]           NAME    19389bytes (2827ms)
>> [00006] READDIR
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
>>   [00006]           NAME    19421bytes (3562ms)
>> [00007] READDIR
>>   [00007]           NAME    19401bytes (162ms)
>> [00008] READDIR
>>   [00008]           NAME    19397bytes (83ms)
>> [00009] READDIR
>>   [00009]           NAME    19429bytes (83ms)
>> [00010] READDIR
>>   [00010]           NAME    19425bytes (83ms)
>> [00011] READDIR
>>   [00011]           NAME    19417bytes (1228ms)
>> [00012] READDIR
>>   [00012]           NAME    19321bytes (164ms)
>> [00013] READDIR
>>   [00013]           NAME    19389bytes (162ms)
>> [00014] READDIR
>>   [00014]           NAME    19405bytes (82ms)
>> [00015] READDIR
>>   [00015]           NAME    19405bytes (1019ms)
>> [00016] READDIR
>>   [00016]           NAME    19445bytes (163ms)
>> [00017] READDIR
>>   [00017]           NAME    19409bytes (162ms)
>> [00018] READDIR
>>   [00018]           NAME    19429bytes (163ms)
>> [00019] READDIR
>>   [00019]           NAME    19389bytes (84ms)
>> [00020] READDIR
>>   [00020]           NAME    19369bytes (1243ms)
>> [00021] READDIR
>>   [00021]           NAME    19453bytes (163ms)
>> [00022] READDIR
>>   [00022]           NAME    19429bytes (161ms)
>> [00023] READDIR
>>   [00023]           NAME    19445bytes (164ms)
>> [00024] READDIR
>>   [00024]           NAME    19399bytes (1014ms)
>> [00025] READDIR
>>   [00025]           NAME    19413bytes (162ms)
>> [00026] READDIR
>>   [00026]           NAME    19409bytes (163ms)
>> [00027] READDIR
>>   [00027]           NAME    19385bytes (162ms)
>> [00028] READDIR
>>   [00028]           NAME    19425bytes (163ms)
>> [00029] READDIR
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a
>>   [00029]           NAME    19393bytes (1226ms)
>> [00030] READDIR
>>   [00030]           NAME    19413bytes (163ms)
>> [00031] READDIR
>>   [00031]           NAME    19413bytes (162ms)
>> [00032] READDIR
>>   [00032]           NAME    19417bytes (162ms)
>> [00033] READDIR
>>   [00033]           NAME    19409bytes (1014ms)
>> [00034] READDIR
>>   [00034]           NAME    19397bytes (162ms)
>> [00035] READDIR
>>   [00035]           NAME    19425bytes (168ms)
>> [00036] READDIR
>>   [00036]           NAME    19441bytes (162ms)
>> [00037] READDIR
>>   [00037]           NAME    19385bytes (82ms)
>> [00038] READDIR
>>   [00038]           NAME    19401bytes (1237ms)
>> [00039] READDIR
>>   [00039]           NAME    19385bytes (162ms)
>> [00040] READDIR
>>   [00040]           NAME    19409bytes (162ms)
>> [00041] READDIR
>>   [00041]           NAME    19417bytes (82ms)
>> [00042] READDIR
>>   [00042]           NAME    19437bytes (1021ms)
>> [00043] READDIR
>>   [00043]           NAME    19425bytes (162ms)
>> [00044] READDIR
>>   [00044]           NAME    19449bytes (163ms)
>> [00045] READDIR
>>   [00045]           NAME    19385bytes (162ms)
>> [00046] READDIR
>>   [00046]           NAME    19441bytes (164ms)
>> [00047] READDIR
>>   [00047]           NAME    19381bytes (962ms)
>> [00048] READDIR
>>   [00048]           NAME    19441bytes (164ms)
>> [00049] READDIR
>>   [00049]           NAME    19393bytes (163ms)
>> [00050] READDIR
>>   [00050]           NAME    19425bytes (88ms)
>> [00051] READDIR
>>   [00051]           NAME    13179bytes (84ms)
>> [00052] READDIR
>>   [00052]         STATUS       32bytes (82ms)
>> [00053] CLOSE
>>    unique: 3, success, outsize: 4112
>> unique: 4, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 4, success, outsize: 4112
>> unique: 5, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 5, success, outsize: 4112
>> unique: 6, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 6, success, outsize: 4112
>> unique: 7, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 7, success, outsize: 4112
>> unique: 8, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 8, success, outsize: 4112
>> unique: 9, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 9, success, outsize: 4112
>> unique: 10, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 10, success, outsize: 4112
>> unique: 11, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 11, success, outsize: 4112
>> unique: 12, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 12, success, outsize: 4112
>> unique: 13, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 13, success, outsize: 4112
>> unique: 14, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 14, success, outsize: 4112
>> unique: 15, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 15, success, outsize: 4112
>> unique: 16, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 16, success, outsize: 4112
>> unique: 17, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 17, success, outsize: 4112
>> unique: 18, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 18, success, outsize: 4112
>> unique: 19, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 19, success, outsize: 4112
>> unique: 20, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 20, success, outsize: 4112
>> unique: 21, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 21, success, outsize: 4112
>> unique: 22, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 22, success, outsize: 4112
>> unique: 23, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 23, success, outsize: 4112
>> unique: 24, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 24, success, outsize: 4112
>> unique: 25, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 25, success, outsize: 4112
>> unique: 26, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 26, success, outsize: 4112
>> unique: 27, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 27, success, outsize: 4112
>> unique: 28, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 28, success, outsize: 4112
>> unique: 29, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 29, success, outsize: 4112
>> unique: 30, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 30, success, outsize: 4112
>> unique: 31, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 31, success, outsize: 4112
>> unique: 32, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 32, success, outsize: 4112
>> unique: 33, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 33, success, outsize: 4112
>> unique: 34, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 34, success, outsize: 4112
>> unique: 35, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 35, success, outsize: 4112
>> unique: 36, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 36, success, outsize: 4112
>> unique: 37, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 37, success, outsize: 4112
>> unique: 38, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 38, success, outsize: 4112
>> unique: 39, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 39, success, outsize: 4112
>> unique: 40, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 40, success, outsize: 4112
>> unique: 41, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 41, success, outsize: 4112
>> unique: 42, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 42, success, outsize: 4112
>> unique: 43, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 43, success, outsize: 4112
>> unique: 44, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 44, success, outsize: 4112
>> unique: 45, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 45, success, outsize: 4112
>> unique: 46, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 46, success, outsize: 4112
>> unique: 47, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 47, success, outsize: 4112
>> unique: 48, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 48, success, outsize: 4112
>> unique: 49, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 49, success, outsize: 4112
>> unique: 50, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 50, success, outsize: 4112
>> unique: 51, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 51, success, outsize: 4112
>> unique: 52, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 52, success, outsize: 4112
>> unique: 53, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 53, success, outsize: 4112
>> unique: 54, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 54, success, outsize: 4112
>> unique: 55, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 55, success, outsize: 4112
>> unique: 56, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 56, success, outsize: 4112
>> unique: 57, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 57, success, outsize: 4112
>> unique: 58, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 58, success, outsize: 4112
>> unique: 59, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 59, success, outsize: 4112
>> unique: 60, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 60, success, outsize: 4112
>> unique: 61, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 61, success, outsize: 4112
>> unique: 62, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 62, success, outsize: 4112
>> unique: 63, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 63, success, outsize: 4112
>> unique: 64, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 64, success, outsize: 4112
>> unique: 65, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 65, success, outsize: 4112
>> unique: 66, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 66, success, outsize: 4112
>> unique: 67, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 67, success, outsize: 4112
>> unique: 68, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 68, success, outsize: 4112
>> unique: 69, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 69, success, outsize: 4112
>> unique: 70, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 70, success, outsize: 4112
>> unique: 71, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 71, success, outsize: 4112
>> unique: 72, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 72, success, outsize: 4112
>> unique: 73, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 73, success, outsize: 4112
>> unique: 74, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 74, success, outsize: 4112
>> unique: 75, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 75, success, outsize: 4112
>> unique: 76, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 76, success, outsize: 4112
>> unique: 77, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 77, success, outsize: 4112
>> unique: 78, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 78, success, outsize: 4112
>> unique: 79, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 79, success, outsize: 4112
>> unique: 80, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 80, success, outsize: 4112
>> unique: 81, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 81, success, outsize: 4112
>> unique: 82, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 82, success, outsize: 4112
>> unique: 83, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 83, success, outsize: 4112
>> unique: 84, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 84, success, outsize: 4112
>> unique: 85, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 85, success, outsize: 4112
>> unique: 86, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 86, success, outsize: 4112
>> unique: 87, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 87, success, outsize: 4112
>> unique: 88, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 88, success, outsize: 4112
>> unique: 89, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 89, success, outsize: 4112
>> unique: 90, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 90, success, outsize: 4112
>> unique: 91, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 91, success, outsize: 4112
>> unique: 92, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 92, success, outsize: 4112
>> unique: 93, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 93, success, outsize: 4112
>> unique: 94, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 94, success, outsize: 4112
>> unique: 95, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 95, success, outsize: 3824
>> unique: 96, opcode: READDIR (28), nodeid: 1, insize: 80
>>    unique: 96, success, outsize: 16
>> unique: 97, opcode: RELEASEDIR (29), nodeid: 1, insize: 64
>>    unique: 97, success, outsize: 16
>> unique: 98, opcode: LOOKUP (1), nodeid: 1, insize: 89
>> LOOKUP /CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170213.pdf
>> getattr /CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170213.pdf
>>    NODEID: 2
>>    unique: 98, success, outsize: 144
>> unique: 99, opcode: GETXATTR (22), nodeid: 2, insize: 68
>>    unique: 99, error: -38 (Function not implemented), outsize: 16
>> unique: 100, opcode: LOOKUP (1), nodeid: 1, insize: 89
>> LOOKUP /CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170301.pdf
>> getattr /CPD_Funding_Grantee_Dash_YUMA-AZ_AZ_20170301.pdf
>>    NODEID: 3
>>    unique: 100, success, outsize: 144
>> unique: 101, opcode: LOOKUP (1), nodeid: 1, insize: 91
>> LOOKUP /CPD_Funding_Grantee_Matrix_YUMA-AZ_AZ_20170301.pdf
>> getattr /CPD_Funding_Grantee_Matrix_YUMA-AZ_AZ_20170301.pdf
>>    NODEID: 4
>>    unique: 101, success, outsize: 144
>>   [00053]         STATUS       28bytes (81ms)
>> unique: 102, opcode: FORGET (2), nodeid: 2, insize: 48
>> FORGET 2/1
>> DELETE: 2
>> unique: 103, opcode: FORGET (2), nodeid: 3, insize: 48
>> FORGET 3/1
>> DELETE: 3
>> unique: 104, opcode: FORGET (2), nodeid: 4, insize: 48
>> FORGET 4/1
>> DELETE: 4
st_expire: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
1 remaining in /mnt/non-co/client_a
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 3
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /mnt/non-co/client_a



^C>> debug1: channel 0: free: client-session, nchannels 1
>> debug1: fd 0 clearing O_NONBLOCK
>> debug1: fd 2 clearing O_NONBLOCK
>> Killed by signal 2.
>> remote host has disconnected
master_notify_state_change: sig 2 switching /mnt/non-co/client_a from 1 to 5
st_prepare_shutdown: state 1 path /mnt/non-co/client_a
expire_proc: exp_proc = 140203840251648 path /mnt/non-co/client_a
expire_proc_indirect: expire /mnt/non-co/client_a/testsftp
>> sent:               53 messages, 918 bytes
>> received:           53 messages, 964161 bytes
>> rtt min/max/avg:    81ms/3562ms/572ms
>> num connect:        1
mount(generic): failed to mount sshfs#redacteduser@redactedhost:/export/home/files (type fuse) on /mnt/non-co/client_a/testsftp
dev_ioctl_send_fail: token = 140
failed to mount /mnt/non-co/client_a/testsftp
expire_cleanup: got thid 140203840251648 path /mnt/non-co/client_a stat 0
expire_cleanup: sigchld: exp 140203840251648 finished, switching from 5 to 7
st_shutdown: state 5 path /mnt/non-co/client_a
umounted indirect mount /net
shut down path /net
umounted indirect mount /misc
shut down path /misc
umount_multi: path /mnt/non-co/client_a incl 0
rm_unwanted_fn: removing directory /mnt/non-co/client_a/testsftp
umounted indirect mount /mnt/non-co/client_a
automount_path_to_fifo: fifo name /var/run/autofs.fifo-mnt-non-icf-client_a
shut down path /mnt/non-co/client_a
autofs stopped
[MYDOM\ME@MYHOST ~]$