Open Stack

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

------------------------------------------
[...truncated 21045 lines...]
++ awk '-F[ \t]*\\|[ \t]*' '{print $2}'
++ read data
+ VOL_ID=bfdf9231-9b21-472b-8edc-c71c049dd45c
+ die_if_not_set 164 VOL_ID 'Failure retrieving volume ID for ex-vol-28648beb'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ DEVICE=/dev/vdb
++ date +%s
+ start_time=1376547418
+ nova volume-attach d0b0510b-588e-4ed7-b7b0-8028ec0ea064 bfdf9231-9b21-472b-8edc-c71c049dd45c /dev/vdb
+----------+--------------------------------------+
| Property | Value                                |
+----------+--------------------------------------+
| device   | /dev/vdb                             |
| serverId | d0b0510b-588e-4ed7-b7b0-8028ec0ea064 |
| id       | bfdf9231-9b21-472b-8edc-c71c049dd45c |
| volumeId | bfdf9231-9b21-472b-8edc-c71c049dd45c |
+----------+--------------------------------------+
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-28648beb | grep in-use; do sleep 1; done'
| bfdf9231-9b21-472b-8edc-c71c049dd45c | in-use | ex-vol-28648beb |  1   |     None    |  False   | d0b0510b-588e-4ed7-b7b0-8028ec0ea064 |
++ date +%s
+ end_time=1376547423
+ echo 'Completed volume-attach in 5 seconds'
Completed volume-attach in 5 seconds
++ cinder list
++ get_field -1
++ read data
++ head -1
++ grep ex-vol-28648beb
++ '[' -1 -lt 0 ']'
++ field='($(NF-1))'
++ echo '| bfdf9231-9b21-472b-8edc-c71c049dd45c | in-use | ex-vol-28648beb |  1   |     None    |  False   | d0b0510b-588e-4ed7-b7b0-8028ec0ea064 |'
++ awk '-F[ \t]*\\|[ \t]*' '{print ($(NF-1))}'
++ read data
+ VOL_ATTACH=d0b0510b-588e-4ed7-b7b0-8028ec0ea064
+ die_if_not_set 178 VOL_ATTACH 'Failure retrieving ex-vol-28648beb status'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ [[ d0b0510b-588e-4ed7-b7b0-8028ec0ea064 != d0b0510b-588e-4ed7-b7b0-8028ec0ea064 ]]
++ date +%s
+ start_time=1376547423
+ nova volume-detach d0b0510b-588e-4ed7-b7b0-8028ec0ea064 bfdf9231-9b21-472b-8edc-c71c049dd45c
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-28648beb | grep available; do sleep 1; done'
| bfdf9231-9b21-472b-8edc-c71c049dd45c | available | ex-vol-28648beb |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1376547426
+ echo 'Completed volume-detach in 3 seconds'
Completed volume-detach in 3 seconds
++ date +%s
+ start_time=1376547426
+ cinder delete bfdf9231-9b21-472b-8edc-c71c049dd45c
+ timeout 90 sh -c 'while cinder list | grep ex-vol-28648beb; do sleep 1; done'
| bfdf9231-9b21-472b-8edc-c71c049dd45c | deleting | ex-vol-28648beb |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1376547429
+ echo 'Completed cinder delete in 3 seconds'
Completed cinder delete in 3 seconds
+ nova delete d0b0510b-588e-4ed7-b7b0-8028ec0ea064
+ timeout 60 sh -c 'while nova list | grep -q d0b0510b-588e-4ed7-b7b0-8028ec0ea064; do sleep 1; done'
+ [[ vol_secgroup = \d\e\f\a\u\l\t ]]
+ 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.a1558.gbc8dbd3.zip
all runtests: commands[0] | python setup.py testr --slowest --testr-args=
running testr
running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-250} \
${PYTHON:-python} -m subunit.run discover -t ./ ./tempest --list 
running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-250} \
${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmp13nykq
running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-250} \
${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpNLmUko
running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-250} \
${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpkcdmJi
running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-250} \
${PYTHON:-python} -m subunit.run discover -t ./ ./tempest  --load-list /tmp/tmpr244ec
======================================================================
FAIL: setUpClass (tempest.whitebox.test_servers_whitebox.ServersWhiteboxTest)
tags: worker-1
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/whitebox/test_servers_whitebox.py", line 30, in setUpClass
    BaseIdentityAdminTest.setUpClass()
  File "tempest/api/identity/base.py", line 28, in setUpClass
    os = clients.AdminManager(interface=cls._interface)
AttributeError: type object 'BaseIdentityAdminTest' has no attribute '_interface'
======================================================================
FAIL: process-returncode
tags: worker-1
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
======================================================================
FAIL: tempest.scenario.test_dashboard_basic_ops.TestDashboardBasicOps.test_basic_scenario
tags: worker-3
----------------------------------------------------------------------
Empty attachments:
  stderr
  stdout

Traceback (most recent call last):
  File "tempest/scenario/test_dashboard_basic_ops.py", line 71, in test_basic_scenario
    self.user_login()
  File "tempest/scenario/test_dashboard_basic_ops.py", line 63, in user_login
    self.opener.open(req, urllib.urlencode(params))
  File "/usr/lib/python2.7/urllib2.py", line 406, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 519, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 438, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 625, in http_error_302
    return self.parent.open(new, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 406, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 519, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 438, in error
    result = self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 625, in http_error_302
    return self.parent.open(new, timeout=req.timeout)
  File "/usr/lib/python2.7/urllib2.py", line 406, in open
    response = meth(req, response)
  File "/usr/lib/python2.7/urllib2.py", line 519, in http_response
    'http', request, response, code, msg, hdrs)
  File "/usr/lib/python2.7/urllib2.py", line 444, in error
    return self._call_chain(*args)
  File "/usr/lib/python2.7/urllib2.py", line 378, in _call_chain
    result = func(*args)
  File "/usr/lib/python2.7/urllib2.py", line 527, in http_error_default
    raise HTTPError(req.get_full_url(), code, msg, hdrs, fp)
HTTPError: HTTP Error 500: INTERNAL SERVER ERROR
======================================================================
FAIL: process-returncode
tags: worker-3
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
Ran 2457 tests in 988.466s
FAILED (id=0, failures=4, skips=64)
error: testr failed (1)
ERROR: InvocationError: '/opt/stack/new/tempest/.tox/all/bin/python setup.py testr --slowest --testr-args='
___________________________________ 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/devstack-precise-hpcloud-az1-10326
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/devstack-gate-cleanup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/devstack-gate-setup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/devstack-gate-setup-workspace-new.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/devstacklog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/iptables.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/kern_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/localrc.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/mysql
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/mysql/error.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/mysql/mysql-slow.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/rabbitmq
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/rabbitmq/rabbit at devstack-1376546467-sasl.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/rabbitmq/rabbit at devstack-1376546467.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/rabbitmq/startup_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-c-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-c-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-c-vol.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-ceilometer-acentral.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-ceilometer-acompute.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-ceilometer-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-ceilometer-collector.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-g-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-g-reg.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-h-api-cfn.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-h-api-cw.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-h-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-h-eng.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-horizon.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-key.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-cond.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-cpu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-crt.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-net.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-obj.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-n-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-s-account.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-s-container.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-s-object.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-s-proxy.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/screen-sysstat.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d/README.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d/cinder-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d/jenkins-sudo-grep.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.d/nova-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sudoers.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/syslog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/sysstat.dat.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/logs/tempest.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/testr_results.html.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-10326/7/subunit_log.txt.gz'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.