See <https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/88/> ------------------------------------------ [...truncated 195 lines...] Loaded extension: os-server-diagnostics Loaded extension: os-console-output Loaded extension: os-security-groups Loaded extension: os-evacuate Loaded extension: os-used-limits Loaded extension: OS-FLV-EXT-DATA Loaded extension: OS-EXT-IMG-SIZE Loaded extension: os-server-start-stop Loaded extension: os-cloudpipe-update Loaded extension: OS-DCF Loaded extension: os-admin-actions Loaded extension: os-attach-interfaces Loaded extension: os-fixed-ips Loaded extension: os-instance_usage_audit_log Loaded extension: os-consoles Loaded extension: os-flavor-access Loaded extension: os-baremetal-nodes osapi_compute listening on 127.0.0.1:44254 http://127.0.0.1:44254/v2 Starting conductor node (version ) (25010) wsgi starting up on http://127.0.0.1:44254/ Doing GET on /v2 (25010) accepted ('127.0.0.1', 56449) 127.0.0.1 "GET /v2 HTTP/1.1" status: 204 len: 216 time: 0.0006411 Doing GET on /v2/openstack//images/detail (25010) accepted ('127.0.0.1', 56450) 127.0.0.1 "GET /v2/openstack//images/detail HTTP/1.1" status: 200 len: 5251 time: 0.7735648 Doing GET on /v2/openstack//flavors/detail (25010) accepted ('127.0.0.1', 56451) 127.0.0.1 "GET /v2/openstack//flavors/detail HTTP/1.1" status: 200 len: 2013 time: 0.0106330 Doing GET on /v2/openstack//servers/detail (25010) accepted ('127.0.0.1', 56452) 127.0.0.1 "GET /v2/openstack//servers/detail HTTP/1.1" status: 200 len: 187 time: 0.0328300 Doing POST on /v2/openstack//servers Body: {"server": {"flavorRef": "http://fake.server/1", "name": "serverIAZFSJOJ", "imageRef": "http://fake.server/70a599e0-31e7-49b7-b260-868f441e862b"}} (25010) accepted ('127.0.0.1', 56453) Starting instance... Attempting claim: memory 512 MB, disk 0 GB, VCPUs 1 Total Memory: 8192 MB, used: 512 MB Memory limit not specified, defaulting to unlimited Total Disk: 1028 GB, used: 0 GB Disk limit not specified, defaulting to unlimited Total CPU: 1 VCPUs, used: 0 VCPUs CPU limit not specified, defaulting to unlimited Claim successful 127.0.0.1 "POST /v2/openstack//servers HTTP/1.1" status: 202 len: 659 time: 0.5807891 Doing GET on /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 (25010) accepted ('127.0.0.1', 56454) 127.0.0.1 "GET /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 HTTP/1.1" status: 200 len: 1470 time: 0.0550590 Doing DELETE on /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 (25010) accepted ('127.0.0.1', 56455) Auditing locally available compute resources 127.0.0.1 "DELETE /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 HTTP/1.1" status: 204 len: 179 time: 0.2628510 Doing GET on /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 (25010) accepted ('127.0.0.1', 56456) Free ram (MB): 7168 Free disk (GB): 1028 Free VCPUS: 0 127.0.0.1 "GET /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 HTTP/1.1" status: 200 len: 1461 time: 0.0861988 Doing POST on /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913/action Body: {"restore": {}} Compute_service record updated for 3b0660858ea9412b9e3f5db00ea4cdbb:fake-mini (25010) accepted ('127.0.0.1', 56457) Reclaiming deleted instance Terminating instance 127.0.0.1 "POST /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913/action HTTP/1.1" status: 202 len: 121 time: 0.3457301 Doing GET on /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 (25010) accepted ('127.0.0.1', 56458) HTTP exception thrown: Instance could not be found 127.0.0.1 "GET /v2/openstack//servers/9d8312e9-8c32-43b0-a3ef-47a7ab739913 HTTP/1.1" status: 404 len: 267 time: 0.0348301 Stopping WSGI server. Updating bandwidth usage cache }}} Traceback (most recent call last): File "<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/nova/tests/integrated/test_servers.py",> line 216, in test_deferred_delete_restore found_server = self._wait_for_state_change(found_server, 'DELETED') File "<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/nova/tests/integrated/test_servers.py",> line 39, in _wait_for_state_change server = self.api.get_server(server['id']) File "<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/nova/tests/integrated/api/client.py",> line 211, in get_server return self.api_get('/servers/%s' % server_id)['server'] File "<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/nova/tests/integrated/api/client.py",> line 180, in api_get response = self.api_request(relative_uri, **kwargs) File "<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/nova/tests/integrated/api/client.py",> line 160, in api_request raise OpenStackApiNotFoundException(response=response) OpenStackApiNotFoundException: Item not found Status Code: 404 Body: {"itemNotFound": {"message": "Instance could not be found", "code": 404}} ====================================================================== FAIL: process-returncode tags: worker-3 ---------------------------------------------------------------------- Binary content: traceback (test/plain; charset="utf8") Ran 5594 tests in 315.464s FAILED (id=0, failures=2, skips=12) error: testr failed (1) ERROR: InvocationError: '<https://jenkins.openstack.org/job/periodic-nova-python27-stable-grizzly/ws/.tox/py27/bin/python> setup.py testr --slowest --testr-args=' ___________________________________ summary ____________________________________ ERROR: py27: commands failed + result=1 + echo 'Begin pip freeze output from test virtualenv:' Begin pip freeze output from test virtualenv: + echo ====================================================================== ====================================================================== + .tox/py27/bin/pip freeze Babel==0.9.6 Cheetah==2.4.4 Jinja2==2.7 Markdown==2.3.1 MarkupSafe==0.18 MySQL-python==1.2.4 Paste==1.7.5.1 PasteDeploy==1.5.0 Pygments==1.6 Routes==1.13 SQLAlchemy==0.7.10 Sphinx==1.2b1 Tempita==0.5.1 WebOb==1.2.3 amqp==1.0.12 amqplib==1.0.2 anyjson==0.3.3 argparse==1.2.1 boto==2.9.6 cliff==1.4 cmd2==0.6.5.1 coverage==3.6 d2to1==0.2.10 decorator==3.4.0 discover==0.4.0 distribute==0.7.3 docutils==0.10 eventlet==0.13.0 extras==0.0.3 feedparser==5.1.3 fixtures==0.3.12 greenlet==0.4.1 httplib2==0.8 iso8601==0.1.4 jsonpatch==1.1 jsonpointer==1.0 jsonschema==2.0.0 kombu==2.5.12 logilab-astng==0.24.3 logilab-common==0.59.1 lxml==3.2.1 mox==0.5.3 netaddr==0.7.10 nova==jenkins.periodic.nova.python27.stable.grizzly.88 numpy==1.7.1 oslo.config==1.1.1 paramiko==1.10.1 pbr==0.5.17 pep8==1.3.3 prettytable==0.7.2 psycopg2==2.5.1 pyOpenSSL==0.13 pyasn1==0.1.7 pycrypto==2.6 pyflakes==0.7.2 pylint==0.25.2 pyparsing==1.5.7 python-cinderclient==1.0.4 python-glanceclient==0.9.0 python-keystoneclient==0.2.5 python-mimeparse==0.1.4 python-quantumclient==2.2.3 python-subunit==0.0.13 repoze.lru==0.6 requests==1.2.3 setuptools-git==1.0b1 simplejson==3.3.0 six==1.3.0 sqlalchemy-migrate==0.7.2 stevedore==0.9.1 suds==0.4 testrepository==0.0.15 testtools==0.9.32 warlock==1.0.1 websockify==0.3.0 wsgiref==0.1.2 + echo ====================================================================== ====================================================================== + '[' -d .testrepository ']' + '[' -f .testrepository/0.2 ']' + '[' -f .testrepository/0 ']' + cp .testrepository/0 ./subunit_log.txt + .tox/py27/bin/python /usr/local/jenkins/slave_scripts/subunit2html.py ./subunit_log.txt testr_results.html nova.tests.integrated.test_servers.ServersTest.test_deferred_delete_restore (subunit.RemotedTestCase) process-returncode (subunit.RemotedTestCase) + gzip -9 ./subunit_log.txt + gzip -9 ./testr_results.html + set -e ++ .tox/py27/bin/python .tox/py27/bin/testr list-tests ++ sed -e 1d ++ wc -l /usr/bin/python: No module named subunit + foundcount=0 ++ .tox/py27/bin/python .tox/py27/bin/testr last ++ sed -ne 's/Ran \([0-9]\+\).*tests in.*/\1/p' + rancount=5594 + '[' 5594 -lt 0 ']' + set +e + sudo /usr/local/jenkins/slave_scripts/jenkins-sudo-grep.sh post + sudoresult=0 + '[' 0 -ne 0 ']' + /usr/local/jenkins/slave_scripts/jenkins-oom-grep.sh post + oomresult=0 + '[' 0 -ne 0 ']' ++ find . -name nose_results.html + htmlreport= + '[' -f '' ']' + echo + echo 'WARNING: Unable to find to confirm results!' WARNING: Unable to find to confirm results! + echo + exit 1 + rm -rf /tmp/tmp.6fTjeEKO9T Build step 'Execute shell' marked build as failure [SCP] Connecting to static.openstack.org [SCP] No file(s) found: **/*nose_results.html [SCP] '**/*nose_results.html' doesn't match anything: '**' exists but not '**/*nose_results.html' [SCP] Connecting to static.openstack.org [SCP] Trying to create /srv/static/logs/periodic/periodic-nova-python27-stable-grizzly/88 [SCP] Copying console log.