Re: [Proftpd-user] mod_sftp slowness - how can I track this down
Michel van der List <[email protected]> Tue, 16 Feb 2021 19:20:08 -0500
| Newsgroups | gmane.network.proftpd.user |
|---|---|
| Message-ID | <[email protected]> |
As a follow up, I created a directory called testing with 200 randomly sized text files. I then connected, and did an ls of the parent directory, which has just the one directory. I then cd to the testing directory and did ls -l. Below is what the trace shows. I think these two lines tell the tale: 2021-02-16 19:10:45,147 [160495] <sftp:7>: received request: READDIR 4acfffceef52753b 2021-02-16 19:10:54,856 [160495] <sftp:8>: sending response: NAME (203 count) This is with selinux. Next test will be turning that off. ------------------------------------------------------- 2021-02-16 19:10:12,921 [160495] <ssh2:9>: loading host key from file '/etc/proftpd/proftpd_host_rsa_key' 2021-02-16 19:10:12,925 [160495] <ssh2:4>: using '/etc/proftpd/proftpd_host_rsa_key' as RSA hostkey 2021-02-16 19:10:12,925 [160495] <ssh2:9>: loading host key from file '/etc/proftpd/proftpd_host_dsa_key' 2021-02-16 19:10:12,926 [160495] <ssh2:4>: using '/etc/proftpd/proftpd_host_dsa_key' as DSA hostkey 2021-02-16 19:10:12,926 [160495] <ssh2:3>: unable to use 'none' cipher: Must be explicitly requested via SFTPCiphers 2021-02-16 19:10:12,926 [160495] <ssh2:3>: unable to use 'none' digest: Must be explicitly requested via SFTPDigests 2021-02-16 19:10:12,926 [160495] <ssh2:9>: sending KEXINIT message to client 2021-02-16 19:10:12,926 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:12,926 [160495] <ssh2:3>: sent SSH_MSG_KEXINIT (20) packet (923 bytes) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:5>: handling connection from SSH2 client 'OpenSSH_8.4' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against regex '^OpenSSH-2\.0.*|^OpenSSH-2\.1.*|^OpenSSH_2\.1.*|^OpenSSH_2\.2.*|^OpenSSH_2\.3\.0.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: client version 'OpenSSH_8.4' did not match regex '^OpenSSH-2\.0.*|^OpenSSH-2\.1.*|^OpenSSH_2\.1.*|^OpenSSH_2\.2.*|^OpenSSH_2\.3\.0.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against regex '^OpenSSH_2\.3\..*|^OpenSSH_2\.5\.0p1.*|^OpenSSH_2\.5\.1p1.*|^OpenSSH_2\.5\.0.*|^OpenSSH_2\.5\.1.*|^OpenSSH_2\.5\.2.*|^OpenSSH_2\.5\.3.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: client version 'OpenSSH_8.4' did not match regex '^OpenSSH_2\.3\..*|^OpenSSH_2\.5\.0p1.*|^OpenSSH_2\.5\.1p1.*|^OpenSSH_2\.5\.0.*|^OpenSSH_2\.5\.1.*|^OpenSSH_2\.5\.2.*|^OpenSSH_2\.5\.3.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against regex '^OpenSSH.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: client version 'OpenSSH_8.4' matched against regex '^OpenSSH.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against SFTPClientMatch regex '.*' 2021-02-16 19:10:12,927 [160495] <ssh2:16>: setting max server channel window size to 1073741824 bytes, as per SFTPClientMatch 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against SFTPClientMatch regex '.*' 2021-02-16 19:10:12,927 [160495] <ssh2:16>: setting max server channel packet size to 262144 bytes, as per SFTPClientMatch 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against SFTPClientMatch regex '.*' 2021-02-16 19:10:12,927 [160495] <ssh2:16>: setting max server channel window size to 1073741824 bytes, as per SFTPClientMatch 2021-02-16 19:10:12,927 [160495] <ssh2:18>: checking client version 'OpenSSH_8.4' against SFTPClientMatch regex '.*WinSCP.*' 2021-02-16 19:10:12,927 [160495] <ssh2:18>: client version 'OpenSSH_8.4' did not match SFTPClientMatch regex '.*WinSCP.*' 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:20>: SSH2 packet len = 1508 bytes 2021-02-16 19:10:12,927 [160495] <ssh2:20>: SSH2 packet padding len = 10 bytes 2021-02-16 19:10:12,927 [160495] <ssh2:20>: SSH2 packet payload len = 1497 bytes 2021-02-16 19:10:12,927 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,927 [160495] <ssh2:20>: SSH2 packet MAC len = 0 bytes 2021-02-16 19:10:12,927 [160495] <ssh2:3>: received SSH_MSG_KEXINIT (20) packet 2021-02-16 19:10:12,927 [160495] <ssh2:9>: reading KEXINIT message from client 2021-02-16 19:10:12,927 [160495] <ssh2:3>: first kex packet follows = false 2021-02-16 19:10:12,927 [160495] <ssh2:9>: determining shared algorithms for SSH session 2021-02-16 19:10:12,927 [160495] <ssh2:8>: client-sent key exchange algorithms: curve25519-sha256,[email protected],ecdh-sha2-nistp256,ecdh-sha2-nistp384,ecdh-sha2-nistp521,diffie-hellman-group-exchange-sha256,diffie-hellman-group16-sha512,diffie-hellman-group18-sha512,diffie-hellman-group14-sha256,ext-info-c 2021-02-16 19:10:12,927 [160495] <ssh2:8>: server-sent key exchange algorithms: ecdh-sha2-nistp521,ecdh-sha2-nistp384,ecdh-sha2-nistp256,diffie-hellman-group18-sha512,diffie-hellman-group16-sha512,diffie-hellman-group14-sha256,diffie-hellman-group-exchange-sha256,diffie-hellman-group-exchange-sha1,diffie-hellman-group14-sha1,rsa1024-sha1 2021-02-16 19:10:12,927 [160495] <ssh2:20>: session key exchange algorithm: ecdh-sha2-nistp256 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent host key algorithms: [email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],ecdsa-sha2-nistp256,ecdsa-sha2-nistp384,ecdsa-sha2-nistp521,[email protected],ssh-ed25519,[email protected],rsa-sha2-512,rsa-sha2-256,ssh-rsa 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent host key algorithms: ssh-rsa,ssh-dss 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session server hostkey algorithm: ssh-rsa 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent client encryption algorithms: [email protected],aes128-ctr,aes192-ctr,aes256-ctr,[email protected],[email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent client encryption algorithms: aes256-ctr,aes192-ctr,aes128-ctr,aes256-cbc,aes192-cbc,aes128-cbc,blowfish-ctr,blowfish-cbc,cast128-cbc,arcfour256,arcfour128,3des-ctr,3des-cbc 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session client-to-server encryption algorithm: aes128-ctr 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent server encryption algorithms: [email protected],aes128-ctr,aes192-ctr,aes256-ctr,[email protected],[email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent server encryption algorithms: aes256-ctr,aes192-ctr,aes128-ctr,aes256-cbc,aes192-cbc,aes128-cbc,blowfish-ctr,blowfish-cbc,cast128-cbc,arcfour256,arcfour128,3des-ctr,3des-cbc 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session server-to-client encryption algorithm: aes128-ctr 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent client MAC algorithms: [email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-sha1 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent client MAC algorithms: hmac-sha2-256,hmac-sha2-512,hmac-sha1,hmac-sha1-96,hmac-md5,hmac-md5-96,hmac-ripemd160,[email protected],[email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session client-to-server MAC algorithm: [email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent server MAC algorithms: [email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-sha1 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent server MAC algorithms: hmac-sha2-256,hmac-sha2-512,hmac-sha1,hmac-sha1-96,hmac-md5,hmac-md5-96,hmac-ripemd160,[email protected],[email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session server-to-client MAC algorithm: [email protected] 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent client compression algorithms: none,[email protected],zlib 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent client compression algorithms: none 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session client-to-server compression algorithm: none 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent server compression algorithms: none,[email protected],zlib 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent server compression algorithms: none 2021-02-16 19:10:12,928 [160495] <ssh2:20>: session server-to-client compression algorithm: none 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent client languages: 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent client languages: 2021-02-16 19:10:12,928 [160495] <ssh2:8>: client-sent server languages: 2021-02-16 19:10:12,928 [160495] <ssh2:8>: server-sent server languages: 2021-02-16 19:10:12,928 [160495] <ssh2:9>: waiting for a message of 3 types from client 2021-02-16 19:10:12,928 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,928 [160495] <ssh2:20>: SSH2 packet len = 76 bytes 2021-02-16 19:10:12,928 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:12,928 [160495] <ssh2:20>: SSH2 packet payload len = 70 bytes 2021-02-16 19:10:12,928 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,928 [160495] <ssh2:20>: SSH2 packet MAC len = 0 bytes 2021-02-16 19:10:12,928 [160495] <ssh2:13>: received expected SSH_MSG_KEX_DH_INIT message 2021-02-16 19:10:12,928 [160495] <ssh2:9>: reading ECDH_INIT message from client 2021-02-16 19:10:12,928 [160495] <ssh2:12>: computing ECDH key 2021-02-16 19:10:12,932 [160495] <ssh2:9>: writing ECDH_INIT message to client 2021-02-16 19:10:12,932 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:12,932 [160495] <ssh2:3>: sent SSH_MSG_KEX_DH_REPLY (31) packet (896 bytes) 2021-02-16 19:10:12,932 [160495] <ssh2:9>: sending NEWKEYS message to client 2021-02-16 19:10:12,932 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:12,933 [160495] <ssh2:3>: sent SSH_MSG_NEWKEYS (21) packet (16 bytes) 2021-02-16 19:10:12,933 [160495] <ssh2:9>: waiting for a message of 1 type from client 2021-02-16 19:10:12,933 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,933 [160495] <ssh2:20>: SSH2 packet len = 12 bytes 2021-02-16 19:10:12,933 [160495] <ssh2:20>: SSH2 packet padding len = 10 bytes 2021-02-16 19:10:12,933 [160495] <ssh2:20>: SSH2 packet payload len = 1 bytes 2021-02-16 19:10:12,933 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,933 [160495] <ssh2:20>: SSH2 packet MAC len = 0 bytes 2021-02-16 19:10:12,933 [160495] <ssh2:13>: received expected SSH_MSG_NEWKEYS message 2021-02-16 19:10:12,933 [160495] <ssh2:9>: setting session keys 2021-02-16 19:10:12,933 [160495] <ssh2:19>: setting key (32 bytes) for cipher aes128-ctr 2021-02-16 19:10:12,933 [160495] <ssh2:19>: hashed data to produce key (32 bytes) 2021-02-16 19:10:12,933 [160495] <ssh2:19>: setting key (32 bytes) for cipher aes128-ctr 2021-02-16 19:10:12,933 [160495] <ssh2:19>: hashed data to produce key (32 bytes) 2021-02-16 19:10:12,933 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,974 [160495] <ssh2:20>: SSH2 packet len = 28 bytes 2021-02-16 19:10:12,974 [160495] <ssh2:20>: SSH2 packet padding len = 10 bytes 2021-02-16 19:10:12,974 [160495] <ssh2:20>: SSH2 packet payload len = 17 bytes 2021-02-16 19:10:12,974 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,974 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:12,974 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,974 [160495] <ssh2:3>: received SSH_MSG_SERVICE_REQUEST (5) packet 2021-02-16 19:10:12,974 [160495] <ssh2:10>: 'ssh-userauth' service requested 2021-02-16 19:10:12,974 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:12,974 [160495] <ssh2:3>: sent SSH_MSG_SERVICE_ACCEPT (6) packet (40 bytes) 2021-02-16 19:10:12,975 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,975 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:12,975 [160495] <ssh2:20>: SSH2 packet padding len = 8 bytes 2021-02-16 19:10:12,975 [160495] <ssh2:20>: SSH2 packet payload len = 35 bytes 2021-02-16 19:10:12,975 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,975 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:12,975 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:12,975 [160495] <ssh2:3>: received SSH_MSG_USER_AUTH_REQUEST (50) packet 2021-02-16 19:10:12,976 [160495] <ssh2:10>: auth requested for user 'vmic', service 'ssh-connection', using method 'none' 2021-02-16 19:10:12,976 [160495] <ssh2:9>: offering authentication methods: password 2021-02-16 19:10:12,976 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:12,976 [160495] <ssh2:3>: sent SSH_MSG_USER_AUTH_FAILURE (51) packet (40 bytes) 2021-02-16 19:10:12,976 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,317 [160495] <ssh2:20>: SSH2 packet len = 124 bytes 2021-02-16 19:10:18,317 [160495] <ssh2:20>: SSH2 packet padding len = 55 bytes 2021-02-16 19:10:18,317 [160495] <ssh2:20>: SSH2 packet payload len = 68 bytes 2021-02-16 19:10:18,317 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,317 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:18,317 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,317 [160495] <ssh2:3>: received SSH_MSG_USER_AUTH_REQUEST (50) packet 2021-02-16 19:10:18,317 [160495] <ssh2:10>: auth requested for user 'vmic', service 'ssh-connection', using method 'password' 2021-02-16 19:10:18,568 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:18,568 [160495] <ssh2:3>: sent SSH_MSG_USER_AUTH_SUCCESS (52) packet (24 bytes) 2021-02-16 19:10:18,569 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,569 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:20>: SSH2 packet padding len = 19 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:20>: SSH2 packet payload len = 24 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,569 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,569 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_OPEN (90) packet 2021-02-16 19:10:18,569 [160495] <ssh2:8>: open of 'session' channel using remote ID 0 requested: initial client window len = 2097152 bytes, client max packet size = 32768 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:8>: confirm open channel remote ID 0, local ID 0: initial server window len = 1073741824 bytes, server max packet size = 262144 bytes 2021-02-16 19:10:18,569 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:18,569 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_OPEN_CONFIRMATION (91) packet (40 bytes) 2021-02-16 19:10:18,569 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet padding len = 16 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet payload len = 27 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_REQUEST (98) packet 2021-02-16 19:10:18,570 [160495] <ssh2:7>: received 'subsystem' request for channel ID 0, want reply = true 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_SUCCESS (99) packet (24 bytes) 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet len = 28 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet padding len = 9 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet payload len = 18 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:18,570 [160495] <ssh2:17>: processing 9 bytes of data for channel ID 0 2021-02-16 19:10:18,570 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (9 bytes) 2021-02-16 19:10:18,570 [160495] <sftp:19>: using 9 bytes of SSH2 packet buffer data 2021-02-16 19:10:18,570 [160495] <sftp:19>: read SFTP request packet len 5 from SSH2 packet buffer (5 bytes remaining in buffer) 2021-02-16 19:10:18,570 [160495] <sftp:19>: read SFTP request type 1 from SSH2 packet buffer (4 bytes remaining in buffer) 2021-02-16 19:10:18,570 [160495] <sftp:19>: read SFTP request payload size 4 from SSH2 packet buffer (4 bytes remaining in buffer) 2021-02-16 19:10:18,570 [160495] <sftp:19>: filling remaining SFTP request payload (4 of 4 total bytes) from SSH2 packet buffer (4 bytes in buffer) 2021-02-16 19:10:18,570 [160495] <sftp:19>: completely filled payload of 4 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:18,570 [160495] <sftp:6>: received INIT (1) SFTP request (channel ID 0) 2021-02-16 19:10:18,570 [160495] <sftp:7>: received request: INIT 3 2021-02-16 19:10:18,570 [160495] <sftp:8>: sending response: VERSION 3 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: versions = '2,3,4,5,6' 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: [email protected] = '1' 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: [email protected] = '1' 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: [email protected] = '2' 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: [email protected] = '2' 2021-02-16 19:10:18,570 [160495] <sftp:11>: + SFTP extension: [email protected] = '1' 2021-02-16 19:10:18,570 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 179 data bytes) 2021-02-16 19:10:18,570 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:18,570 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (216 bytes) 2021-02-16 19:10:18,570 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096973 bytes 2021-02-16 19:10:18,571 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,571 [160495] <ssh2:20>: SSH2 packet len = 28 bytes 2021-02-16 19:10:18,571 [160495] <ssh2:20>: SSH2 packet padding len = 4 bytes 2021-02-16 19:10:18,571 [160495] <ssh2:20>: SSH2 packet payload len = 23 bytes 2021-02-16 19:10:18,571 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,571 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:18,571 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:18,571 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:18,571 [160495] <ssh2:17>: processing 14 bytes of data for channel ID 0 2021-02-16 19:10:18,571 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (14 bytes) 2021-02-16 19:10:18,571 [160495] <sftp:19>: using 14 bytes of SSH2 packet buffer data 2021-02-16 19:10:18,571 [160495] <sftp:19>: read SFTP request packet len 10 from SSH2 packet buffer (10 bytes remaining in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:19>: read SFTP request type 16 from SSH2 packet buffer (9 bytes remaining in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:19>: read SFTP request payload size 9 from SSH2 packet buffer (9 bytes remaining in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:19>: read SFTP request ID 1 from SSH2 packet buffer (5 bytes remaining in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:19>: filling remaining SFTP request payload (5 of 5 total bytes) from SSH2 packet buffer (5 bytes in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:19>: completely filled payload of 5 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:18,571 [160495] <sftp:6>: received REALPATH (16) SFTP request (request ID 1, channel ID 0) 2021-02-16 19:10:18,571 [160495] <sftp:7>: received request: REALPATH . 2021-02-16 19:10:18,618 [160495] <sftp:8>: sending response: NAME 1 / type=dir;size=39;UNIX.owner=14;UNIX.group=50;UNIX.mode=0755;access=20210216231649;modify=20210216230517; 2021-02-16 19:10:18,618 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 83 data bytes) 2021-02-16 19:10:18,618 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:18,618 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (120 bytes) 2021-02-16 19:10:18,618 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096890 bytes 2021-02-16 19:10:18,618 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,902 [160495] <ssh2:20>: SSH2 packet len = 28 bytes 2021-02-16 19:10:39,902 [160495] <ssh2:20>: SSH2 packet padding len = 4 bytes 2021-02-16 19:10:39,902 [160495] <ssh2:20>: SSH2 packet payload len = 23 bytes 2021-02-16 19:10:39,902 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,902 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:39,902 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,902 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:39,902 [160495] <ssh2:17>: processing 14 bytes of data for channel ID 0 2021-02-16 19:10:39,902 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (14 bytes) 2021-02-16 19:10:39,902 [160495] <sftp:19>: using 14 bytes of SSH2 packet buffer data 2021-02-16 19:10:39,902 [160495] <sftp:19>: read SFTP request packet len 10 from SSH2 packet buffer (10 bytes remaining in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:19>: read SFTP request type 11 from SSH2 packet buffer (9 bytes remaining in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:19>: read SFTP request payload size 9 from SSH2 packet buffer (9 bytes remaining in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:19>: read SFTP request ID 2 from SSH2 packet buffer (5 bytes remaining in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:19>: filling remaining SFTP request payload (5 of 5 total bytes) from SSH2 packet buffer (5 bytes in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:19>: completely filled payload of 5 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:39,902 [160495] <sftp:6>: received OPENDIR (11) SFTP request (request ID 2, channel ID 0) 2021-02-16 19:10:39,902 [160495] <sftp:7>: received request: OPENDIR / 2021-02-16 19:10:39,952 [160495] <sftp:8>: sending response: HANDLE bbfab65c9f9eccf3 2021-02-16 19:10:39,952 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 29 data bytes) 2021-02-16 19:10:39,952 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:39,952 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (56 bytes) 2021-02-16 19:10:39,952 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096861 bytes 2021-02-16 19:10:39,952 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,953 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:39,953 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:39,953 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:39,953 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,953 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:39,953 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:39,953 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:39,953 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:39,953 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:39,953 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:39,953 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:19>: read SFTP request type 12 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:19>: read SFTP request ID 3 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:39,953 [160495] <sftp:6>: received READDIR (12) SFTP request (request ID 3, channel ID 0) 2021-02-16 19:10:39,953 [160495] <sftp:7>: received request: READDIR bbfab65c9f9eccf3 2021-02-16 19:10:40,282 [160495] <sftp:8>: sending response: NAME (4 count) 2021-02-16 19:10:40,282 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 98 bytes 2021-02-16 19:10:40,282 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 100 bytes 2021-02-16 19:10:40,282 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 116 bytes 2021-02-16 19:10:40,330 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 110 bytes 2021-02-16 19:10:40,330 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 437 data bytes) 2021-02-16 19:10:40,330 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:40,330 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (472 bytes) 2021-02-16 19:10:40,330 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096424 bytes 2021-02-16 19:10:40,330 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,331 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:40,331 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:40,331 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:40,331 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,331 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:40,331 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,331 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:40,331 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:40,331 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:40,331 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:40,331 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:19>: read SFTP request type 12 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:19>: read SFTP request ID 4 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:40,331 [160495] <sftp:6>: received READDIR (12) SFTP request (request ID 4, channel ID 0) 2021-02-16 19:10:40,331 [160495] <sftp:7>: received request: READDIR bbfab65c9f9eccf3 2021-02-16 19:10:40,472 [160495] <sftp:8>: sending response: STATUS 1 'End of file' 2021-02-16 19:10:40,472 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 37 data bytes) 2021-02-16 19:10:40,472 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:40,472 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (72 bytes) 2021-02-16 19:10:40,472 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096387 bytes 2021-02-16 19:10:40,472 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,473 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:40,473 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:40,473 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:40,473 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,473 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:40,473 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:40,473 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:40,473 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:40,473 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:40,473 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:40,473 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:19>: read SFTP request type 4 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:19>: read SFTP request ID 5 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:40,473 [160495] <sftp:6>: received CLOSE (4) SFTP request (request ID 5, channel ID 0) 2021-02-16 19:10:40,473 [160495] <sftp:7>: received request: CLOSE bbfab65c9f9eccf3 2021-02-16 19:10:40,473 [160495] <sftp:8>: sending response: STATUS 0 'OK' 2021-02-16 19:10:40,473 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 28 data bytes) 2021-02-16 19:10:40,473 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:40,473 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (56 bytes) 2021-02-16 19:10:40,473 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096359 bytes 2021-02-16 19:10:40,473 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,918 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:43,918 [160495] <ssh2:20>: SSH2 packet padding len = 13 bytes 2021-02-16 19:10:43,918 [160495] <ssh2:20>: SSH2 packet payload len = 30 bytes 2021-02-16 19:10:43,918 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,918 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:43,918 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,918 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:43,918 [160495] <ssh2:17>: processing 21 bytes of data for channel ID 0 2021-02-16 19:10:43,918 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (21 bytes) 2021-02-16 19:10:43,918 [160495] <sftp:19>: using 21 bytes of SSH2 packet buffer data 2021-02-16 19:10:43,918 [160495] <sftp:19>: read SFTP request packet len 17 from SSH2 packet buffer (17 bytes remaining in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:19>: read SFTP request type 16 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:19>: read SFTP request payload size 16 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:19>: read SFTP request ID 6 from SSH2 packet buffer (12 bytes remaining in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:19>: filling remaining SFTP request payload (12 of 12 total bytes) from SSH2 packet buffer (12 bytes in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:19>: completely filled payload of 12 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:43,918 [160495] <sftp:6>: received REALPATH (16) SFTP request (request ID 6, channel ID 0) 2021-02-16 19:10:43,918 [160495] <sftp:7>: received request: REALPATH /testing 2021-02-16 19:10:43,918 [160495] <sftp:15>: resolved client-sent path '/testing' to local path '/testing' 2021-02-16 19:10:43,968 [160495] <sftp:8>: sending response: NAME 1 /testing type=dir;size=8192;UNIX.owner=1000;UNIX.group=50;UNIX.mode=0755;access=20210217000827;modify=20210217000826; 2021-02-16 19:10:43,968 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 97 data bytes) 2021-02-16 19:10:43,968 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:43,968 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (136 bytes) 2021-02-16 19:10:43,968 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096262 bytes 2021-02-16 19:10:43,968 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,969 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:43,969 [160495] <ssh2:20>: SSH2 packet padding len = 13 bytes 2021-02-16 19:10:43,969 [160495] <ssh2:20>: SSH2 packet payload len = 30 bytes 2021-02-16 19:10:43,969 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,969 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:43,969 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:43,969 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:43,969 [160495] <ssh2:17>: processing 21 bytes of data for channel ID 0 2021-02-16 19:10:43,969 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (21 bytes) 2021-02-16 19:10:43,969 [160495] <sftp:19>: using 21 bytes of SSH2 packet buffer data 2021-02-16 19:10:43,969 [160495] <sftp:19>: read SFTP request packet len 17 from SSH2 packet buffer (17 bytes remaining in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:19>: read SFTP request type 17 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:19>: read SFTP request payload size 16 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:19>: read SFTP request ID 7 from SSH2 packet buffer (12 bytes remaining in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:19>: filling remaining SFTP request payload (12 of 12 total bytes) from SSH2 packet buffer (12 bytes in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:19>: completely filled payload of 12 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:43,969 [160495] <sftp:6>: received STAT (17) SFTP request (request ID 7, channel ID 0) 2021-02-16 19:10:43,969 [160495] <sftp:7>: received request: STAT /testing 2021-02-16 19:10:44,016 [160495] <sftp:8>: sending response: ATTRS type=dir;size=8192;UNIX.owner=1000;UNIX.group=50;UNIX.mode=0755;access=20210217000827;modify=20210217000826; 2021-02-16 19:10:44,016 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 104 data bytes) 2021-02-16 19:10:44,016 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:44,016 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (136 bytes) 2021-02-16 19:10:44,016 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096158 bytes 2021-02-16 19:10:44,016 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,094 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:45,094 [160495] <ssh2:20>: SSH2 packet padding len = 13 bytes 2021-02-16 19:10:45,094 [160495] <ssh2:20>: SSH2 packet payload len = 30 bytes 2021-02-16 19:10:45,094 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,094 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:45,094 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,094 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:45,094 [160495] <ssh2:17>: processing 21 bytes of data for channel ID 0 2021-02-16 19:10:45,094 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (21 bytes) 2021-02-16 19:10:45,094 [160495] <sftp:19>: using 21 bytes of SSH2 packet buffer data 2021-02-16 19:10:45,094 [160495] <sftp:19>: read SFTP request packet len 17 from SSH2 packet buffer (17 bytes remaining in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:19>: read SFTP request type 11 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:19>: read SFTP request payload size 16 from SSH2 packet buffer (16 bytes remaining in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:19>: read SFTP request ID 8 from SSH2 packet buffer (12 bytes remaining in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:19>: filling remaining SFTP request payload (12 of 12 total bytes) from SSH2 packet buffer (12 bytes in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:19>: completely filled payload of 12 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:45,094 [160495] <sftp:6>: received OPENDIR (11) SFTP request (request ID 8, channel ID 0) 2021-02-16 19:10:45,094 [160495] <sftp:7>: received request: OPENDIR /testing 2021-02-16 19:10:45,146 [160495] <sftp:8>: sending response: HANDLE 4acfffceef52753b 2021-02-16 19:10:45,146 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 29 data bytes) 2021-02-16 19:10:45,146 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:45,146 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (56 bytes) 2021-02-16 19:10:45,146 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2096129 bytes 2021-02-16 19:10:45,146 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,147 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:45,147 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:45,147 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:45,147 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,147 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:45,147 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:45,147 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:45,147 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:45,147 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:45,147 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:45,147 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:19>: read SFTP request type 12 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:19>: read SFTP request ID 9 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:45,147 [160495] <sftp:6>: received READDIR (12) SFTP request (request ID 9, channel ID 0) 2021-02-16 19:10:45,147 [160495] <sftp:7>: received request: READDIR 4acfffceef52753b 2021-02-16 19:10:54,856 [160495] <sftp:8>: sending response: NAME (203 count) 2021-02-16 19:10:54,856 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 98 bytes 2021-02-16 19:10:54,856 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 100 bytes 2021-02-16 19:10:54,856 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 116 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,903 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,904 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <sftp:19>: READDIR: FXP_NAME entry size: 136 bytes 2021-02-16 19:10:54,905 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 27527 data bytes) 2021-02-16 19:10:54,906 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:54,906 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (27560 bytes) 2021-02-16 19:10:54,906 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2068602 bytes 2021-02-16 19:10:54,906 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:54,908 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:54,908 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:54,908 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:54,908 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:54,908 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:54,908 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:54,908 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:54,908 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:54,908 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:54,908 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:54,908 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:19>: read SFTP request type 12 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:19>: read SFTP request ID 10 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:54,908 [160495] <sftp:6>: received READDIR (12) SFTP request (request ID 10, channel ID 0) 2021-02-16 19:10:54,909 [160495] <sftp:7>: received request: READDIR 4acfffceef52753b 2021-02-16 19:10:55,060 [160495] <sftp:8>: sending response: STATUS 1 'End of file' 2021-02-16 19:10:55,060 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 37 data bytes) 2021-02-16 19:10:55,060 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:55,060 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (72 bytes) 2021-02-16 19:10:55,060 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2068565 bytes 2021-02-16 19:10:55,060 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:55,061 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:55,061 [160495] <ssh2:20>: SSH2 packet padding len = 5 bytes 2021-02-16 19:10:55,061 [160495] <ssh2:20>: SSH2 packet payload len = 38 bytes 2021-02-16 19:10:55,061 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:55,061 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:55,061 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:55,061 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_DATA (94) packet 2021-02-16 19:10:55,061 [160495] <ssh2:17>: processing 29 bytes of data for channel ID 0 2021-02-16 19:10:55,061 [160495] <sftp:9>: reading SFTP data from SSH2 packet buffer (29 bytes) 2021-02-16 19:10:55,061 [160495] <sftp:19>: using 29 bytes of SSH2 packet buffer data 2021-02-16 19:10:55,061 [160495] <sftp:19>: read SFTP request packet len 25 from SSH2 packet buffer (25 bytes remaining in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:19>: read SFTP request type 4 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:19>: read SFTP request payload size 24 from SSH2 packet buffer (24 bytes remaining in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:19>: read SFTP request ID 11 from SSH2 packet buffer (20 bytes remaining in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:19>: filling remaining SFTP request payload (20 of 20 total bytes) from SSH2 packet buffer (20 bytes in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:19>: completely filled payload of 20 bytes (0 bytes remaining in buffer) 2021-02-16 19:10:55,061 [160495] <sftp:6>: received CLOSE (4) SFTP request (request ID 11, channel ID 0) 2021-02-16 19:10:55,061 [160495] <sftp:7>: received request: CLOSE 4acfffceef52753b 2021-02-16 19:10:55,061 [160495] <sftp:8>: sending response: STATUS 0 'OK' 2021-02-16 19:10:55,061 [160495] <ssh2:9>: sending CHANNEL_DATA (remote channel ID 0, 28 data bytes) 2021-02-16 19:10:55,061 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:55,061 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_DATA (94) packet (56 bytes) 2021-02-16 19:10:55,062 [160495] <ssh2:11>: channel ID 0 remote window size currently at 2068537 bytes 2021-02-16 19:10:55,062 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,734 [160495] <ssh2:20>: SSH2 packet len = 12 bytes 2021-02-16 19:10:56,734 [160495] <ssh2:20>: SSH2 packet padding len = 6 bytes 2021-02-16 19:10:56,734 [160495] <ssh2:20>: SSH2 packet payload len = 5 bytes 2021-02-16 19:10:56,734 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:56,734 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,734 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_EOF (96) packet 2021-02-16 19:10:56,734 [160495] <ssh2:9>: sending CHANNEL_REQUEST (remote channel ID 0, exit status 0) 2021-02-16 19:10:56,734 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:56,734 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_REQUEST (98) packet (56 bytes) 2021-02-16 19:10:56,734 [160495] <ssh2:9>: sending CHANNEL_EOF (remote channel ID 0) 2021-02-16 19:10:56,734 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:56,734 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_EOF (96) packet (24 bytes) 2021-02-16 19:10:56,734 [160495] <ssh2:9>: sending CHANNEL_CLOSE (remote channel ID 0) 2021-02-16 19:10:56,734 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 1 for writing using select(2) 2021-02-16 19:10:56,734 [160495] <ssh2:3>: sent SSH_MSG_CHANNEL_CLOSE (97) packet (24 bytes) 2021-02-16 19:10:56,735 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet len = 12 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet padding len = 6 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet payload len = 5 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,735 [160495] <ssh2:3>: received SSH_MSG_CHANNEL_CLOSE (97) packet 2021-02-16 19:10:56,735 [160495] <ssh2:15>: calling finish handler for channel ID 0 2021-02-16 19:10:56,735 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet len = 44 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet padding len = 10 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet payload len = 33 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,735 [160495] <ssh2:20>: SSH2 packet MAC len = 8 bytes 2021-02-16 19:10:56,735 [160495] <ssh2:19>: waiting for max of 300 secs while polling socket 0 for reading using select(2) 2021-02-16 19:10:56,735 [160495] <ssh2:3>: received SSH_MSG_DISCONNECT (1) packet 2021-02-16 19:10:56,735 [160495] <ssh2:19>: client sent DISCONNECT language tag '' _______________________________________________ ProFTPD Users List <[email protected]> Unsubscribe problems? http://www.proftpd.org/list-unsub.html