Open Stack

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

------------------------------------------
[...truncated 22430 lines...]
Completed cinder create in 3 seconds
++ cinder list
++ grep ex-vol-fec49752
++ head -1
++ get_field 1
++ read data
++ '[' 1 -lt 0 ']'
++ field='$2'
++ echo '| f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e | available | ex-vol-fec49752 |  1   |     None    |  False   |             |'
++ awk '-F[ \t]*\\|[ \t]*' '{print $2}'
++ read data
+ VOL_ID=f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e
+ die_if_not_set 158 VOL_ID 'Failure retrieving volume ID for ex-vol-fec49752'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ DEVICE=/dev/vdb
++ date +%s
+ start_time=1375078268
+ nova volume-attach ca998e6e-f9db-44b7-af04-6bfec953e849 f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e /dev/vdb
+----------+--------------------------------------+
| Property | Value                                |
+----------+--------------------------------------+
| device   | /dev/vdb                             |
| serverId | ca998e6e-f9db-44b7-af04-6bfec953e849 |
| id       | f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e |
| volumeId | f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e |
+----------+--------------------------------------+
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-fec49752 | grep in-use; do sleep 1; done'
| f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e | in-use | ex-vol-fec49752 |  1   |     None    |  False   | ca998e6e-f9db-44b7-af04-6bfec953e849 |
++ date +%s
+ end_time=1375078272
+ echo 'Completed volume-attach in 4 seconds'
Completed volume-attach in 4 seconds
++ cinder list
++ head -1
++ get_field -1
++ read data
++ grep ex-vol-fec49752
++ '[' -1 -lt 0 ']'
++ field='($(NF-1))'
++ echo '| f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e | in-use | ex-vol-fec49752 |  1   |     None    |  False   | ca998e6e-f9db-44b7-af04-6bfec953e849 |'
++ awk '-F[ \t]*\\|[ \t]*' '{print ($(NF-1))}'
++ read data
+ VOL_ATTACH=ca998e6e-f9db-44b7-af04-6bfec953e849
+ die_if_not_set 172 VOL_ATTACH 'Failure retrieving ex-vol-fec49752 status'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ [[ ca998e6e-f9db-44b7-af04-6bfec953e849 != ca998e6e-f9db-44b7-af04-6bfec953e849 ]]
++ date +%s
+ start_time=1375078272
+ nova volume-detach ca998e6e-f9db-44b7-af04-6bfec953e849 f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-fec49752 | grep available; do sleep 1; done'
| f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e | available | ex-vol-fec49752 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1375078275
+ echo 'Completed volume-detach in 3 seconds'
Completed volume-detach in 3 seconds
++ date +%s
+ start_time=1375078275
+ cinder delete f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e
+ timeout 90 sh -c 'while cinder list | grep ex-vol-fec49752; do sleep 1; done'
| f59e3cfd-ee8c-4707-ac94-fb971c1e9c4e | deleting | ex-vol-fec49752 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1375078278
+ echo 'Completed cinder delete in 3 seconds'
Completed cinder delete in 3 seconds
+ nova delete ca998e6e-f9db-44b7-af04-6bfec953e849
+ timeout 60 sh -c 'while nova list | grep -q ca998e6e-f9db-44b7-af04-6bfec953e849; 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.a1439.g0c8da88.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/tmpWHjJ8_
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpkuNiXu
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmprKzOue
running=${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpU9L2yA
======================================================================
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-d1b8afce-d3e4-40d9-bef8-b6a9d0c47fb4)
======================================================================
FAIL: process-returncode
tags: worker-0
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
Ran 2374 tests in 877.227s
FAILED (id=0, failures=5, skips=64)
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/49
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/devstack-gate-cleanup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/devstack-gate-setup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/devstack-gate-setup-workspace-new.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/devstacklog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/iptables.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/kern_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/localrc.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/mysql
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/mysql/error.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/mysql/mysql-slow.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/rabbitmq
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/rabbitmq/rabbit at devstack-1375074066-sasl.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/rabbitmq/rabbit at devstack-1375074066.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/rabbitmq/startup_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-c-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-c-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-c-vol.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-ceilometer-acentral.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-ceilometer-acompute.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-ceilometer-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-ceilometer-collector.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-g-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-g-reg.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-h-api-cfn.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-h-api-cw.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-h-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-h-eng.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-horizon.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-key.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-cond.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-cpu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-crt.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-net.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-obj.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-n-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-s-account.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-s-container.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-s-object.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-s-proxy.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/screen-sysstat.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d/README.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d/cinder-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d/jenkins-sudo-grep.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.d/nova-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sudoers.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/syslog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/logs/sysstat.dat.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/testr_results.html.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/49/subunit_log.txt.gz'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.