If it helps, I just kill -HUP'ed one of the ssh processes and got a lot of
debug output:
failed: [host1] => (item=git,supervisor) => {"failed": true, "item":
"git,supervisor", "parsed": false}
invalid output was: SUDO-SUCCESS-kmkiimakutvlojnbqartowszmpdbndzk
OpenSSH_6.2p2, OSSLShim 0.9.8r 8 Dec 2011
debug1: Reading configuration data /Users/toreo/.ssh/config
debug1: Reading configuration data /etc/ssh_config
debug1: /etc/ssh_config line 20: Applying options for *
debug1: /etc/ssh_config line 53: Applying options for *
debug2: ssh_connect: needpriv 0
debug1: Connecting to host1 [<ip-addr>] port 22.
debug2: fd 3 setting O_NONBLOCK
debug1: fd 3 clearing O_NONBLOCK
debug1: Connection established.
debug3: timeout: 9894 ms remain after connect
debug3: Incorrect RSA1 identifier
debug3: Could not load "/Users/toreo/.ssh/cargame-ssh.pem" as a RSA1 public
key
debug1: identity file /Users/toreo/.ssh/cargame-ssh.pem type -1
debug1: identity file /Users/toreo/.ssh/cargame-ssh.pem-cert type -1
debug1: Enabling compatibility mode for protocol 2.0
debug1: Local version string SSH-2.0-OpenSSH_6.2
debug1: Remote protocol version 2.0, remote software version
OpenSSH_6.6.1p1 Ubuntu-2ubuntu2
debug1: match: OpenSSH_6.6.1p1 Ubuntu-2ubuntu2 pat OpenSSH*
debug2: fd 3 setting O_NONBLOCK
debug3: load_hostkeys: loading entries for host "host1" from file
"/Users/toreo/.ssh/known_hosts"
debug3: load_hostkeys: found key type RSA in file
/Users/toreo/.ssh/known_hosts:42
debug3: load_hostkeys: loaded 1 keys
debug3: order_hostkeyalgs: prefer hostkeyalgs:
[email protected],[email protected],ssh-rsa
debug1: SSH2_MSG_KEXINIT sent
debug1: SSH2_MSG_KEXINIT received
debug2: kex_parse_kexinit:
diffie-hellman-group-exchange-sha256,diffie-hellman-group-exchange-sha1,diffie-hellman-group14-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit:
[email protected],[email protected],ssh-rsa,[email protected],[email protected],ssh-dss
debug2: kex_parse_kexinit:
aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,[email protected],[email protected],aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,aes192-cbc,aes256-cbc,arcfour,[email protected]
debug2: kex_parse_kexinit:
aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,[email protected],[email protected],aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,aes192-cbc,aes256-cbc,arcfour,[email protected]
debug2: kex_parse_kexinit:
[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-md5,hmac-sha1,[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-ripemd160,[email protected],hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit:
[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-md5,hmac-sha1,[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-ripemd160,[email protected],hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: [email protected],zlib,none
debug2: kex_parse_kexinit: [email protected],zlib,none
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug2: kex_parse_kexinit:
[email protected],ecdh-sha2-nistp256,ecdh-sha2-nistp384,ecdh-sha2-nistp521,diffie-hellman-group-exchange-sha256,diffie-hellman-group-exchange-sha1,diffie-hellman-group14-sha1,diffie-hellman-group1-sha1
debug2: kex_parse_kexinit: ssh-rsa,ssh-dss,ecdsa-sha2-nistp256
debug2: kex_parse_kexinit:
aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,[email protected],[email protected],[email protected],aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,aes192-cbc,aes256-cbc,arcfour,[email protected]
debug2: kex_parse_kexinit:
aes128-ctr,aes192-ctr,aes256-ctr,arcfour256,arcfour128,[email protected],[email protected],[email protected],aes128-cbc,3des-cbc,blowfish-cbc,cast128-cbc,aes192-cbc,aes256-cbc,arcfour,[email protected]
debug2: kex_parse_kexinit:
[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-md5,hmac-sha1,[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-ripemd160,[email protected],hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit:
[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],[email protected],hmac-md5,hmac-sha1,[email protected],[email protected],hmac-sha2-256,hmac-sha2-512,hmac-ripemd160,[email protected],hmac-sha1-96,hmac-md5-96
debug2: kex_parse_kexinit: none,[email protected]
debug2: kex_parse_kexinit: none,[email protected]
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit:
debug2: kex_parse_kexinit: first_kex_follows 0
debug2: kex_parse_kexinit: reserved 0
debug2: mac_setup: found [email protected]
debug1: kex: server->client aes128-ctr [email protected]
[email protected]
debug2: mac_setup: found [email protected]
debug1: kex: client->server aes128-ctr [email protected]
[email protected]
debug1: SSH2_MSG_KEX_DH_GEX_REQUEST(1024<1024<8192) sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_GROUP
debug2: dh_gen_key: priv key bits set: 126/256
debug2: bits set: 494/1024
debug1: SSH2_MSG_KEX_DH_GEX_INIT sent
debug1: expecting SSH2_MSG_KEX_DH_GEX_REPLY
debug1: Server host key: RSA 90:5b:60:eb:fd:c3:96:b1:83:b7:9f:5e:b4:bd:c0:b3
debug3: load_hostkeys: loading entries for host "host1" from file
"/Users/toreo/.ssh/known_hosts"
debug3: load_hostkeys: found key type RSA in file
/Users/toreo/.ssh/known_hosts:42
debug3: load_hostkeys: loaded 1 keys
debug3: load_hostkeys: loading entries for host "<ip-addr>" from file
"/Users/toreo/.ssh/known_hosts"
debug3: load_hostkeys: found key type RSA in file
/Users/toreo/.ssh/known_hosts:42
debug3: load_hostkeys: loaded 1 keys
debug1: Host 'host1' is known and matches the RSA host key.
debug1: Found key in /Users/toreo/.ssh/known_hosts:42
debug2: bits set: 519/1024
debug1: ssh_rsa_verify: signature correct
debug2: kex_derive_keys
debug2: set_newkeys: mode 1
debug1: SSH2_MSG_NEWKEYS sent
debug1: expecting SSH2_MSG_NEWKEYS
debug2: set_newkeys: mode 0
debug1: SSH2_MSG_NEWKEYS received
debug1: Roaming not allowed by server
debug1: SSH2_MSG_SERVICE_REQUEST sent
debug2: service_accept: ssh-userauth
debug1: SSH2_MSG_SERVICE_ACCEPT received
debug2: key: /Users/toreo/.ssh/id_rsa (0x7f816ab01280),
debug2: key: /Users/toreo/.ssh/cargame-ssh.pem (0x0), explicit
debug1: Authentications that can continue: publickey
debug3: start over, passed a different list publickey
debug3: preferred gssapi-with-mic,gssapi-keyex,hostbased,publickey
debug3: authmethod_lookup publickey
debug3: remaining preferred: ,gssapi-keyex,hostbased,publickey
debug3: authmethod_is_enabled publickey
debug1: Next authentication method: publickey
debug1: Offering RSA public key: /Users/toreo/.ssh/id_rsa
debug3: send_pubkey_test
debug2: we sent a publickey packet, wait for reply
debug1: Authentications that can continue: publickey
debug1: Trying private key: /Users/toreo/.ssh/cargame-ssh.pem
debug1: read PEM private key done: type RSA
debug3: sign_and_send_pubkey: RSA
fd:98:17:09:b8:20:08:c2:66:d9:54:07:e6:04:b9:23
debug2: we sent a publickey packet, wait for reply
debug1: Enabling compression at level 6.
debug1: Authentication succeeded (publickey).
Authenticated to host1 ([<ip-addr>]:22).
debug2: fd 6 setting O_NONBLOCK
debug2: fd 7 setting O_NONBLOCK
debug1: channel 0: new [client-session]
debug3: ssh_session2_open: channel_new: 0
debug2: channel 0: send open
debug1: Requesting [email protected]
debug1: Entering interactive session.
debug2: callback start
debug1: Requesting authentication agent forwarding.
debug2: channel 0: request [email protected] confirm 0
debug2: fd 3 setting TCP_NODELAY
debug3: packet_set_tos: set IP_TOS 0x10
debug2: client_session2_setup: id 0
debug2: channel 0: request pty-req confirm 1
debug1: Sending environment.
debug3: Ignored env VIRTUALENVWRAPPER_PROJECT_FILENAME
debug3: Ignored env TERM_PROGRAM
debug3: Ignored env TERM
debug3: Ignored env SHELL
debug3: Ignored env TMPDIR
debug3: Ignored env Apple_PubSub_Socket_Render
debug3: Ignored env TERM_PROGRAM_VERSION
debug3: Ignored env TERM_SESSION_ID
debug3: Ignored env USER
debug3: Ignored env SSH_AUTH_SOCK
debug3: Ignored env __CF_USER_TEXT_ENCODING
debug3: Ignored env WORKON_HOME
debug3: Ignored env PATH
debug3: Ignored env VIRTUALENVWRAPPER_HOOK_DIR
debug3: Ignored env PWD
debug3: Ignored env XPC_FLAGS
debug3: Ignored env PS1
debug3: Ignored env XPC_SERVICE_NAME
debug3: Ignored env HOME
debug3: Ignored env SHLVL
debug3: Ignored env LOGNAME
debug1: Sending env LC_CTYPE = UTF-8
debug2: channel 0: request env confirm 0
debug3: Ignored env GOPATH
debug3: Ignored env DISPLAY
debug3: Ignored env VIRTUALENVWRAPPER_LOG_DIR
debug3: Ignored env SECURITYSESSIONID
debug3: Ignored env OLDPWD
debug3: Ignored env _
debug3: Ignored env VERSIONER_PYTHON_VERSION
debug3: Ignored env VERSIONER_PYTHON_PREFER_32_BIT
debug1: Sending command: /bin/sh -c 'sudo -k && sudo -H -S -p "[sudo via
ansible, key=kmkiimakutvlojnbqartowszmpdbndzk] password: " -u root /bin/sh
-c '"'"'echo SUDO-SUCCESS-kmkiimakutvlojnbqartowszmpdbndzk;
LANG=en_US.UTF-8 LC_CTYPE=en_US.UTF-8 /usr/bin/python
/home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790/apt; rm
-rf /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790/
>/dev/null 2>&1'"'"''
debug2: channel 0: request exec confirm 1
debug2: callback done
debug2: channel 0: open confirm rwindow 0 rmax 32768
debug2: channel_input_status_confirm: type 99 id 0
debug2: PTY allocation request accepted on channel 0
debug2: channel 0: rcvd adjust 2097152
debug2: channel_input_status_confirm: type 99 id 0
debug2: exec request accepted on channel 0
debug1: channel 0: free: client-session, nchannels 1
debug3: channel 0: status: The following connections are open:
#0 client-session (t4 r0 i0/0 o0/0 fd 5/6 cc -1)
debug1: fd 1 clearing O_NONBLOCK
debug1: fd 2 clearing O_NONBLOCK
Killed by signal 1.
On Friday, November 14, 2014 12:52:01 PM UTC+1, Tore Olsen wrote:
>
> Just thought I'd follow up with a typical output with -vvvv; This is a
> play where I'm installing a couple of apt packages to three AWS hosts
> (shortened host1-3 for brevity). You see one of the hosts succeed while the
> other two apparently do not. The one that succeeds is in EU (Ireland) while
> the unfinished hosts are both in different AZs in East US.
>
> I logged in to the hosts which did not resume play and verified that the
> temporary directory actually had been deleted.
>
>
> TASK: [common | Install common packages]
> **************************************
> <host1> ESTABLISH CONNECTION FOR USER: ubuntu
> <host2> ESTABLISH CONNECTION FOR USER: ubuntu
> <host3> ESTABLISH CONNECTION FOR USER: ubuntu
> <host2> REMOTE_MODULE apt pkg=git,supervisor update_cache=yes state=present
> <host1> REMOTE_MODULE apt pkg=git,supervisor update_cache=yes state=present
> <host3> REMOTE_MODULE apt pkg=git,supervisor update_cache=yes state=present
> <host2> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host2', "/bin/sh -c 'mkdir -p
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031 && chmod a+rx
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031 && echo
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031'"]
> <host1> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host1', "/bin/sh -c 'mkdir -p
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790 && chmod a+rx
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790 && echo
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790'"]
> <host3> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host3', "/bin/sh -c 'mkdir -p
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899 && chmod a+rx
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899 && echo
> $HOME/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899'"]
> <host3> PUT /var/folders/f6/hp9f9y0933q95_9mlbhk27dm0000gn/T/tmpQGGHOr TO
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899/apt
> <host1> PUT /var/folders/f6/hp9f9y0933q95_9mlbhk27dm0000gn/T/tmp38enSO TO
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790/apt
> <host2> PUT /var/folders/f6/hp9f9y0933q95_9mlbhk27dm0000gn/T/tmpYViEBl TO
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031/apt
> <host3> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host3', u'/bin/sh -c \'sudo -k && sudo -H -S -p
> "[sudo via ansible, key=uuhortuzkrrxndipfnakoyezwvmlbrrg] password: " -u
> root /bin/sh -c \'"\'"\'echo SUDO-SUCCESS-uuhortuzkrrxndipfnakoyezwvmlbrrg;
> LANG=en_US.UTF-8 LC_CTYPE=en_US.UTF-8 /usr/bin/python
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899/apt; rm
> -rf /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-65992156942899/
> >/dev/null 2>&1\'"\'"\'\'']
> <host1> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host1', u'/bin/sh -c \'sudo -k && sudo -H -S -p
> "[sudo via ansible, key=kmkiimakutvlojnbqartowszmpdbndzk] password: " -u
> root /bin/sh -c \'"\'"\'echo SUDO-SUCCESS-kmkiimakutvlojnbqartowszmpdbndzk;
> LANG=en_US.UTF-8 LC_CTYPE=en_US.UTF-8 /usr/bin/python
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790/apt; rm
> -rf /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-242263817184790/
> >/dev/null 2>&1\'"\'"\'\'']
> <host2> EXEC ['ssh', '-C', '-tt', '-vvv', '-o', 'ForwardAgent=yes', '-o',
> 'IdentityFile="/Users/toreo/.ssh/cargame-ssh.pem"', '-o',
> 'KbdInteractiveAuthentication=no', '-o',
> 'PreferredAuthentications=gssapi-with-mic,gssapi-keyex,hostbased,publickey',
> '-o', 'PasswordAuthentication=no', '-o', 'User=ubuntu', '-o',
> 'ConnectTimeout=10', u'host2', u'/bin/sh -c \'sudo -k && sudo -H -S -p
> "[sudo via ansible, key=iyzsrbntouwziaxcxllqidtsopvifmac] password: " -u
> root /bin/sh -c \'"\'"\'echo SUDO-SUCCESS-iyzsrbntouwziaxcxllqidtsopvifmac;
> LANG=en_US.UTF-8 LC_CTYPE=en_US.UTF-8 /usr/bin/python
> /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031/apt; rm
> -rf /home/ubuntu/.ansible/tmp/ansible-tmp-1415964802.72-81109603826031/
> >/dev/null 2>&1\'"\'"\'\'']
> ok: [host3] => (item=git,supervisor) => {"changed": false, "item":
> "git,supervisor"}
>
>
> On Tuesday, November 11, 2014 1:53:57 PM UTC+1, Tore Olsen wrote:
>>
>> Hello,
>>
>> I'm having problems with SSH connections hanging seemingly indefinitely.
>> I don't recognize any patterns as to what tasks or handlers this happens
>> on. I'm running ansible 1.7.1 on OS X Yosemite against a bunch of ec2
>> instances. I also deploy to vagrant but don't think it has had similar SSH
>> hangs.
>>
>> Today I determined to kill -HUP the ssh process that was hung, and then
>> ansible resumed happily.
>>
>> I'd be grateful if anyone has troubleshooting tips for this.
>>
>> -Tore
>>
>>
>>
>>
>>
>>
--
You received this message because you are subscribed to the Google Groups
"Ansible Project" group.
To unsubscribe from this group and stop receiving emails from it, send an email
to [email protected].
To post to this group, send email to [email protected].
To view this discussion on the web visit
https://groups.google.com/d/msgid/ansible-project/a2bc61e5-d056-4c9b-b3fd-7c8281983ccc%40googlegroups.com.
For more options, visit https://groups.google.com/d/optout.