Open Stack

See <https://jenkins.openstack.org/job/periodic-tempest-devstack-vm-all/48/>

------------------------------------------
[...truncated 22450 lines...]
+----------+--------------------------------------+
| Property | Value                                |
+----------+--------------------------------------+
| device   | /dev/vdb                             |
| serverId | 960bd2a4-e55a-4031-904f-1898fb6a60df |
| id       | 31a9f185-6aed-4102-aca8-e378660f1986 |
| volumeId | 31a9f185-6aed-4102-aca8-e378660f1986 |
+----------+--------------------------------------+
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-540ff428 | grep in-use; do sleep 1; done'
| 31a9f185-6aed-4102-aca8-e378660f1986 | in-use | ex-vol-540ff428 |  1   |     None    |  False   | 960bd2a4-e55a-4031-904f-1898fb6a60df |
++ date +%s
+ end_time=1374991849
+ echo 'Completed volume-attach in 3 seconds'
Completed volume-attach in 3 seconds
++ cinder list
++ grep ex-vol-540ff428
++ head -1
++ get_field -1
++ read data
++ '[' -1 -lt 0 ']'
++ field='($(NF-1))'
++ awk '-F[ \t]*\\|[ \t]*' '{print ($(NF-1))}'
++ echo '| 31a9f185-6aed-4102-aca8-e378660f1986 | in-use | ex-vol-540ff428 |  1   |     None    |  False   | 960bd2a4-e55a-4031-904f-1898fb6a60df |'
++ read data
+ VOL_ATTACH=960bd2a4-e55a-4031-904f-1898fb6a60df
+ die_if_not_set 172 VOL_ATTACH 'Failure retrieving ex-vol-540ff428 status'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ [[ 960bd2a4-e55a-4031-904f-1898fb6a60df != 960bd2a4-e55a-4031-904f-1898fb6a60df ]]
++ date +%s
+ start_time=1374991850
+ nova volume-detach 960bd2a4-e55a-4031-904f-1898fb6a60df 31a9f185-6aed-4102-aca8-e378660f1986
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-540ff428 | grep available; do sleep 1; done'
| 31a9f185-6aed-4102-aca8-e378660f1986 | available | ex-vol-540ff428 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1374991853
+ echo 'Completed volume-detach in 3 seconds'
Completed volume-detach in 3 seconds
++ date +%s
+ start_time=1374991853
+ cinder delete 31a9f185-6aed-4102-aca8-e378660f1986
+ timeout 90 sh -c 'while cinder list | grep ex-vol-540ff428; do sleep 1; done'
| 31a9f185-6aed-4102-aca8-e378660f1986 | deleting | ex-vol-540ff428 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1374991855
+ echo 'Completed cinder delete in 2 seconds'
Completed cinder delete in 2 seconds
+ nova delete 960bd2a4-e55a-4031-904f-1898fb6a60df
+ timeout 60 sh -c 'while nova list | grep -q 960bd2a4-e55a-4031-904f-1898fb6a60df; do sleep 1; done'
+ nova secgroup-delete vol_secgroup
+----+--------------+--------------------------+
| Id | Name         | Description              |
+----+--------------+--------------------------+
| 5  | vol_secgroup | vol_secgroup description |
+----+--------------+--------------------------+
+ set +o xtrace
*********************************************************************
SUCCESS: End DevStack Exercise: /opt/stack/new/devstack/exercises/volumes.sh
*********************************************************************
=====================================================================
SKIP boot_from_volume
SKIP client-env
SKIP neutron-adv-test
PASS aggregates
PASS bundle
PASS client-args
PASS euca
PASS floating_ips
PASS horizon
PASS sec_groups
PASS swift
PASS volumes
=====================================================================
Running tempest all test suite
GLOB sdist-make: /opt/stack/new/tempest/setup.py
all create: /opt/stack/new/tempest/.tox/all
all inst: /opt/stack/new/tempest/.tox/dist/tempest-2013.2.a1436.g7f5e65b.zip
all runtests: commands[0] | python setup.py testr --slowest
running testr
No handlers could be found for logger "tempest.api.compute.base"
No handlers could be found for logger "tempest.cli.output_parser"
No handlers could be found for logger "tempest.cli"
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest --list 
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpt04rFA
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpHpfz43
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpmcWT1U
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpbpv8Vq
======================================================================
FAIL: tempest.api.compute.admin.test_aggregates.AggregatesAdminTestXML.test_aggregate_add_host_create_server_with_az[gate]
tags: worker-0
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/api/compute/admin/test_aggregates.py", line 213, in test_aggregate_add_host_create_server_with_az
    availability_zone=az_name)
  File "tempest/api/compute/base.py", line 123, in create_server
    name, image_id, flavor, **kwargs)
  File "tempest/services/compute/xml/servers_client.py", line 304, in create_server
    resp, body = self.post('servers', str(Document(server)), self.headers)
  File "tempest/common/rest_client.py", line 258, in post
    return self.request('POST', url, headers, body)
  File "tempest/common/rest_client.py", line 386, in request
    resp, resp_body)
  File "tempest/common/rest_client.py", line 436, in _error_checker
    raise exceptions.BadRequest(resp_body)
BadRequest: Bad request
Details: {'message': 'The requested availability zone is not available', 'code': '400'}
======================================================================
FAIL: tempest.api.compute.admin.test_aggregates.AggregatesAdminTestJSON.test_aggregate_add_host_create_server_with_az[gate]
tags: worker-2
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/api/compute/admin/test_aggregates.py", line 213, in test_aggregate_add_host_create_server_with_az
    availability_zone=az_name)
  File "tempest/api/compute/base.py", line 123, in create_server
    name, image_id, flavor, **kwargs)
  File "tempest/services/compute/json/servers_client.py", line 81, in create_server
    resp, body = self.post('servers', post_body, self.headers)
  File "tempest/common/rest_client.py", line 258, in post
    return self.request('POST', url, headers, body)
  File "tempest/common/rest_client.py", line 386, in request
    resp, resp_body)
  File "tempest/common/rest_client.py", line 436, in _error_checker
    raise exceptions.BadRequest(resp_body)
BadRequest: Bad request
Details: {u'badRequest': {u'message': u'The requested availability zone is not available', u'code': 400}}
======================================================================
FAIL: process-returncode
tags: worker-2
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
======================================================================
FAIL: tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern
tags: worker-0
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/scenario/test_snapshot_pattern.py", line 133, in test_snapshot_pattern
    self._create_security_group_rule()
  File "tempest/scenario/test_snapshot_pattern.py", line 84, in _create_security_group_rule
    **ruleset)
  File "/opt/stack/new/python-novaclient/novaclient/v1_1/security_group_rules.py", line 69, in create
    'security_group_rule')
  File "/opt/stack/new/python-novaclient/novaclient/base.py", line 141, in _create
    _resp, body = self.api.client.post(url, body=body)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 232, in post
    return self._cs_request(url, 'POST', **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 213, in _cs_request
    **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 195, in _time_request
    resp, body = self.request(url, method, **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 189, in request
    raise exceptions.from_response(resp, body, url, method)
BadRequest: This rule already exists in group 1 (HTTP 400) (Request-ID: req-70e1b005-4d41-4a80-b7a7-28ee5f38fbfa)
======================================================================
FAIL: tempest.scenario.test_stamp_pattern.TestStampPattern.test_stamp_pattern
tags: worker-0
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/scenario/test_stamp_pattern.py", line 203, in test_stamp_pattern
    self._create_security_group_rule()
  File "tempest/scenario/test_stamp_pattern.py", line 106, in _create_security_group_rule
    **ruleset)
  File "/opt/stack/new/python-novaclient/novaclient/v1_1/security_group_rules.py", line 69, in create
    'security_group_rule')
  File "/opt/stack/new/python-novaclient/novaclient/base.py", line 141, in _create
    _resp, body = self.api.client.post(url, body=body)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 232, in post
    return self._cs_request(url, 'POST', **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 213, in _cs_request
    **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 195, in _time_request
    resp, body = self.request(url, method, **kwargs)
  File "/opt/stack/new/python-novaclient/novaclient/client.py", line 189, in request
    raise exceptions.from_response(resp, body, url, method)
BadRequest: This rule already exists in group 1 (HTTP 400) (Request-ID: req-2b3dedce-6650-4aa9-abbb-f299f14086d5)
======================================================================
FAIL: process-returncode
tags: worker-0
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
Ran 2374 tests in 873.418s
FAILED (id=0, failures=6, skips=63)
error: testr failed (1)
ERROR: InvocationError: '/opt/stack/new/tempest/.tox/all/bin/python setup.py testr --slowest'
___________________________________ summary ____________________________________
ERROR:   all: commands failed
Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information
Build step 'Execute shell' marked build as failure
[SCP] Connecting to static.openstack.org
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/devstack-gate-cleanup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/devstack-gate-setup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/devstack-gate-setup-workspace-new.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/devstacklog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/iptables.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/kern_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/localrc.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/mysql
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/mysql/error.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/mysql/mysql-slow.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/rabbitmq
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/rabbitmq/rabbit at devstack-1374978670-sasl.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/rabbitmq/rabbit at devstack-1374978670.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/rabbitmq/startup_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-c-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-c-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-c-vol.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-ceilometer-acentral.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-ceilometer-acompute.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-ceilometer-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-ceilometer-collector.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-g-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-g-reg.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-h-api-cfn.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-h-api-cw.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-h-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-h-eng.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-horizon.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-key.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-cond.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-cpu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-crt.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-net.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-obj.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-n-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-s-account.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-s-container.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-s-object.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-s-proxy.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/screen-sysstat.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d/README.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d/cinder-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d/jenkins-sudo-grep.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.d/nova-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sudoers.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/syslog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/logs/sysstat.dat.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/testr_results.html.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/48/subunit_log.txt.gz'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.