paramiko ValueError: Unable to compute factors p and q from exponent d

[Dolph Mathews]

From: http://logs.openstack.org/91/87091/5/check/check-tempest-dsvm-neutron-icehouse/0bcf992/console.html

2014-04-25 01:04:10.545 | 2014-04-25 00:56:45,517 Creating ssh connection to '172.24.4.70' as 'cirros' with public key authentication
2014-04-25 01:04:10.545 | 2014-04-25 00:56:50,514 Failed to establish authenticated ssh connection to cirros@172.24.4.70 ([Errno 113] No route to host). Number attempts: 1. Retry after 2 seconds.
2014-04-25 01:04:10.545 | 2014-04-25 00:56:56,014 Failed to establish authenticated ssh connection to cirros@172.24.4.70 ([Errno 113] No route to host). Number attempts: 2. Retry after 3 seconds.
2014-04-25 01:04:10.545 | 2014-04-25 00:56:59,569 Failed to establish authenticated ssh connection to cirros@172.24.4.70 ([Errno 111] Connection refused). Number attempts: 3. Retry after 4 seconds.
2014-04-25 01:04:10.545 | 2014-04-25 00:57:04,126 starting thread (client mode): 0xa515a50L
2014-04-25 01:04:10.545 | 2014-04-25 00:57:04,147 Connected (version 2.0, client dropbear_2012.55)
2014-04-25 01:04:10.545 | 2014-04-25 00:57:04,153 kex algos:[u'diffie-hellman-group1-sha1', u'diffie-hellman-group14-sha1'] server key:[u'ssh-rsa', u'ssh-dss'] client encrypt:[u'aes128-ctr', u'3des-ctr', u'aes256-ctr', u'aes128-cbc', u'3des-cbc', u'aes256-cbc', u'twofish256-cbc', u'twofish-cbc', u'twofish128-cbc'] server encrypt:[u'aes128-ctr', u'3des-ctr', u'aes256-ctr', u'aes128-cbc', u'3des-cbc', u'aes256-cbc', u'twofish256-cbc', u'twofish-cbc', u'twofish128-cbc'] client mac:[u'hmac-sha1-96', u'hmac-sha1', u'hmac-md5'] server mac:[u'hmac-sha1-96', u'hmac-sha1', u'hmac-md5'] client compress:[u'none'] server compress:[u'none'] client lang:[u''] server lang:[u''] kex follows?False
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,153 Ciphers agreed: local=aes128-ctr, remote=aes128-ctr
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,153 using kex diffie-hellman-group1-sha1; server key type ssh-rsa; cipher: local aes128-ctr, remote aes128-ctr; mac: local hmac-sha1, remote hmac-sha1; compression: local none, remote none
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,280 Switch to new keys ...
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,292 Adding ssh-rsa host key for 172.24.4.70: 648f164faf433e0c015b96c8c5d1d8da
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,292 Trying SSH key da5dc8ecbf343d65c9f5523afa754874
2014-04-25 01:04:10.546 | 2014-04-25 00:57:04,295 userauth is OK
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,702 Unknown exception: Unable to compute factors p and q from exponent d.
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,704 Traceback (most recent call last):
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,704 File "/usr/local/lib/python2.7/dist-packages/paramiko/transport.py", line 1461, in run
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,704 self.auth_handler._handler_table[ptype](self.auth_handler, m)
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,704 File "/usr/local/lib/python2.7/dist-packages/paramiko/auth_handler.py", line 209, in _parse_service_accept
2014-04-25 01:04:10.546 | 2014-04-25 00:57:07,705 sig = self.private_key.sign_ssh_data(self.transport.rng, blob)
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 File "/usr/local/lib/python2.7/dist-packages/paramiko/rsakey.py", line 95, in sign_ssh_data
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 rsa = RSA.construct((long(self.n), long(self.e), long(self.d)))
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 File "/usr/local/lib/python2.7/dist-packages/Crypto/PublicKey/RSA.py", line 539, in construct
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 key = self._math.rsa_construct(*tup)
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 File "/usr/local/lib/python2.7/dist-packages/Crypto/PublicKey/_slowmath.py", line 132, in rsa_construct
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 raise ValueError("Unable to compute factors p and q from exponent d.")
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705 ValueError: Unable to compute factors p and q from exponent d.
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,705
2014-04-25 01:04:10.547 | 2014-04-25 00:57:07,712
2014-04-25 01:04:10.580 | REQ: curl -i 'http://127.0.0.1:8774/v2/c13819a83f26445e94f0961d5ca21d70/os-floating-ips/bb25efa0-3af7-46d1-beb5-486a37b6c00e' -X DELETE -H "X-Auth-Project-Id: TestSnapshotPattern-1661522015" -H "User-Agent: python-novaclient" -H "Accept: application/json" -H "X-Auth-Token: <stripped> -mLbbGx1gbGbPhkLYc5y6OSYzRjHiczZBffCveRE9cdANeME0EG4gKiubl7Jv4UpxNeTeqABdASm7LwAzkzhFk3rnNiN3-AJOLsHKQQgKC+tgahx2evn6svtUjjTbBMRkM+w3XnTvDSEkpxslYPnO1iK1Dcq++3Mf7ybv3oSGRQXSPoLuMYdA8qpyKAoPlPKyV1quLJ8fL6YX-OZkVwO9pV4hJNXs8PIA2swg9ygO1cER55C2YvAMpIJ7b7e7J4eFAQWLWUQZ6DcKT91EeSDDvVNSaMfjzOxALYEz4bWQ-pMeKH8RSn565XbFf6MVeOck16Oz-bi9Mt7VOdAJ3pq"
2014-04-25 01:04:10.580 |
2014-04-25 01:04:10.580 | 2014-04-25 00:57:07,713 Starting new HTTP connection (1): 127.0.0.1
2014-04-25 01:04:10.581 | 2014-04-25 00:57:08,396 "DELETE /v2/c13819a83f26445e94f0961d5ca21d70/os-floating-ips/bb25efa0-3af7-46d1-beb5-486a37b6c00e HTTP/1.1" 202 0
2014-04-25 01:04:10.581 | 2014-04-25 00:57:08,397 RESP: [202] CaseInsensitiveDict({'date': 'Fri, 25 Apr 2014 00:57:08 GMT', 'content-length': '0', 'content-type': 'text/html; charset=UTF-8', 'x-compute-request-id': 'req-84b4d850-28e3-444b-be8f-67264250ba38'})
2014-04-25 01:04:10.581 | RESP BODY:
2014-04-25 01:04:10.581 | }}}
2014-04-25 01:04:10.581 |
2014-04-25 01:04:10.581 | Traceback (most recent call last):
2014-04-25 01:04:10.581 | File "tempest/test.py", line 126, in wrapper
2014-04-25 01:04:10.581 | return f(self, *func_args, **func_kwargs)
2014-04-25 01:04:10.581 | File "tempest/scenario/test_snapshot_pattern.py", line 82, in test_snapshot_pattern
2014-04-25 01:04:10.581 | self._write_timestamp(fip_for_server.ip)
2014-04-25 01:04:10.581 | File "tempest/scenario/test_snapshot_pattern.py", line 55, in _write_timestamp
2014-04-25 01:04:10.581 | ssh_client.exec_command('date > /tmp/timestamp; sync')
2014-04-25 01:04:10.582 | File "tempest/common/utils/linux/remote_client.py", line 47, in exec_command
2014-04-25 01:04:10.582 | return self.ssh_client.exec_command(cmd)
2014-04-25 01:04:10.582 | File "tempest/common/ssh.py", line 110, in exec_command
2014-04-25 01:04:10.582 | ssh = self._get_ssh_connection()
2014-04-25 01:04:10.582 | File "tempest/common/ssh.py", line 75, in _get_ssh_connection
2014-04-25 01:04:10.582 | timeout=self.channel_timeout, pkey=self.pkey)
2014-04-25 01:04:10.582 | File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 273, in connect
2014-04-25 01:04:10.582 | self._auth(username, password, pkey, key_filenames, allow_agent, look_for_keys)
2014-04-25 01:04:10.582 | File "/usr/local/lib/python2.7/dist-packages/paramiko/client.py", line 376, in _auth
2014-04-25 01:04:10.582 | allowed_types = self._transport.auth_publickey(username, pkey)
2014-04-25 01:04:10.582 | File "/usr/local/lib/python2.7/dist-packages/paramiko/transport.py", line 1124, in auth_publickey
2014-04-25 01:04:10.582 | return self.auth_handler.wait_for_response(my_event)
2014-04-25 01:04:10.583 | File "/usr/local/lib/python2.7/dist-packages/paramiko/auth_handler.py", line 165, in wait_for_response
2014-04-25 01:04:10.583 | raise e
2014-04-25 01:04:10.583 | ValueError: Unable to compute factors p and q from exponent d.

[OpenStack Infra (hudson-openstack)]

Related fix proposed to branch: master
Review: https://review.openstack.org/101236

[Dolph Mathews (dolph)]

Elastic recheck query: https://review.openstack.org/101236

This has 15 hits in the last few weeks, all of which are on HP nodes (perhaps by coincidence, of course):

build_node
  46% devstack-precise-hpcloud-b3-449284
  26% devstack-precise-hpcloud-b1-411043
  20% devstack-precise-hpcloud-b5-383399
  6% [u'devstack-precise-hpcloud-b1-411043', u'devstack-precise-hpcloud-b3-411115']

[Dolph Mathews (dolph)]

My mistake; I was only querying a subset of the failures above. This happens at both rax & HP and actually has 106 hits in the last 2 weeks.

[OpenStack Infra (hudson-openstack)]

Reviewed: https://review.openstack.org/101236
Committed: https://git.openstack.org/cgit/openstack-infra/elastic-recheck/commit/?id=33f21c05050e896c5cc45432e6796fbd28e40d0b
Submitter: Jenkins
Branch: master

commit 33f21c05050e896c5cc45432e6796fbd28e40d0b
Author: Dolph Mathews <email address hidden>
Date: Thu Jun 19 10:45:36 2014 -0500

    Add query for paramiko exception

    This is an exception raised by paramiko, which has 106 hits over the last
    2 weeks - all of which are failures.

    Change-Id: I8bbb3156dd68f54ec010de1951b1fc6cfecf8931
    Related-Bug: 1313168

[Matt Riedemann (mriedem)]

There have been no updates on this in nearly 2 years, and it hasn't been hitting in e-r for a long time, so can't we close this out now?