Open Stack

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

------------------------------------------
[...truncated 21851 lines...]
--- 10.1.0.2 ping statistics ---
1 packets transmitted, 1 received, 0% packet loss, time 0ms
rtt min/avg/max/mdev = 5.573/5.573/5.573/0.000 ms
++ cinder list
++ grep ex-vol-68558724
++ get_field 2
++ read data
++ head -1
+ [[ -n '' ]]
++ date +%s
+ start_time=1377168261
+ cinder create --display_name ex-vol-68558724 --display_description 'test volume: ex-vol-68558724' 1
+---------------------+--------------------------------------+
|       Property      |                Value                 |
+---------------------+--------------------------------------+
|     attachments     |                  []                  |
|  availability_zone  |                 nova                 |
|       bootable      |                False                 |
|      created_at     |      2013-08-22T10:44:22.203597      |
| display_description |     test volume: ex-vol-68558724     |
|     display_name    |           ex-vol-68558724            |
|          id         | 9a894216-df4d-4366-9703-d5369fb8bb0b |
|       metadata      |                  {}                  |
|         size        |                  1                   |
|     snapshot_id     |                 None                 |
|     source_volid    |                 None                 |
|        status       |               creating               |
|     volume_type     |                 None                 |
+---------------------+--------------------------------------+
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-68558724 | grep available; do sleep 1; done'
| 9a894216-df4d-4366-9703-d5369fb8bb0b | available | ex-vol-68558724 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1377168264
+ echo 'Completed cinder create in 3 seconds'
Completed cinder create in 3 seconds
++ cinder list
++ grep ex-vol-68558724
++ get_field 1
++ read data
++ head -1
++ '[' 1 -lt 0 ']'
++ field='$2'
++ echo '| 9a894216-df4d-4366-9703-d5369fb8bb0b | available | ex-vol-68558724 |  1   |     None    |  False   |             |'
++ awk '-F[ \t]*\\|[ \t]*' '{print $2}'
++ read data
+ VOL_ID=9a894216-df4d-4366-9703-d5369fb8bb0b
+ die_if_not_set 165 VOL_ID 'Failure retrieving volume ID for ex-vol-68558724'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ DEVICE=/dev/vdb
++ date +%s
+ start_time=1377168265
+ nova volume-attach c2cbfdf6-5c17-4d67-aaf1-a0f814141620 9a894216-df4d-4366-9703-d5369fb8bb0b /dev/vdb
ERROR:root:Could not find any typelib for GnomeKeyring
+----------+--------------------------------------+
| Property | Value                                |
+----------+--------------------------------------+
| device   | /dev/vdb                             |
| serverId | c2cbfdf6-5c17-4d67-aaf1-a0f814141620 |
| id       | 9a894216-df4d-4366-9703-d5369fb8bb0b |
| volumeId | 9a894216-df4d-4366-9703-d5369fb8bb0b |
+----------+--------------------------------------+
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-68558724 | grep in-use; do sleep 1; done'
| 9a894216-df4d-4366-9703-d5369fb8bb0b | in-use | ex-vol-68558724 |  1   |     None    |  False   | c2cbfdf6-5c17-4d67-aaf1-a0f814141620 |
++ date +%s
+ end_time=1377168269
+ echo 'Completed volume-attach in 4 seconds'
Completed volume-attach in 4 seconds
++ cinder list
++ grep ex-vol-68558724
++ get_field -1
++ head -1
++ read data
++ '[' -1 -lt 0 ']'
++ field='($(NF-1))'
++ echo '| 9a894216-df4d-4366-9703-d5369fb8bb0b | in-use | ex-vol-68558724 |  1   |     None    |  False   | c2cbfdf6-5c17-4d67-aaf1-a0f814141620 |'
++ awk '-F[ \t]*\\|[ \t]*' '{print ($(NF-1))}'
++ read data
+ VOL_ATTACH=c2cbfdf6-5c17-4d67-aaf1-a0f814141620
+ die_if_not_set 179 VOL_ATTACH 'Failure retrieving ex-vol-68558724 status'
+ local exitcode=0
++ set +o
++ grep xtrace
+ FXTRACE='set -o xtrace'
+ set +o xtrace
+ [[ c2cbfdf6-5c17-4d67-aaf1-a0f814141620 != c2cbfdf6-5c17-4d67-aaf1-a0f814141620 ]]
++ date +%s
+ start_time=1377168270
+ nova volume-detach c2cbfdf6-5c17-4d67-aaf1-a0f814141620 9a894216-df4d-4366-9703-d5369fb8bb0b
ERROR:root:Could not find any typelib for GnomeKeyring
+ timeout 90 sh -c 'while ! cinder list | grep ex-vol-68558724 | grep available; do sleep 1; done'
| 9a894216-df4d-4366-9703-d5369fb8bb0b | available | ex-vol-68558724 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1377168273
+ echo 'Completed volume-detach in 3 seconds'
Completed volume-detach in 3 seconds
++ date +%s
+ start_time=1377168273
+ cinder delete 9a894216-df4d-4366-9703-d5369fb8bb0b
+ timeout 90 sh -c 'while cinder list | grep ex-vol-68558724; do sleep 1; done'
| 9a894216-df4d-4366-9703-d5369fb8bb0b | deleting | ex-vol-68558724 |  1   |     None    |  False   |             |
++ date +%s
+ end_time=1377168276
+ echo 'Completed cinder delete in 3 seconds'
Completed cinder delete in 3 seconds
+ nova delete c2cbfdf6-5c17-4d67-aaf1-a0f814141620
ERROR:root:Could not find any typelib for GnomeKeyring
+ timeout 60 sh -c 'while nova list | grep -q c2cbfdf6-5c17-4d67-aaf1-a0f814141620; do sleep 1; done'
ERROR:root:Could not find any typelib for GnomeKeyring
ERROR:root:Could not find any typelib for GnomeKeyring
ERROR:root:Could not find any typelib for GnomeKeyring
+ [[ vol_secgroup = \d\e\f\a\u\l\t ]]
+ nova secgroup-delete vol_secgroup
ERROR:root:Could not find any typelib for GnomeKeyring
+----+--------------+--------------------------+
| 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.a1594.geff800e.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/tmpfbmnm9
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/tmpq7eND3
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/tmpgojBpB
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/tmp_vB2GX
======================================================================
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 29, 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")
Ran 2473 tests in 829.065s
FAILED (id=0, failures=2, skips=68)
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-152021
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/devstack-gate-cleanup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/devstack-gate-setup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/devstack-gate-setup-workspace-new.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/devstacklog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/iptables.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/kern_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/localrc.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/mysql
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/mysql/error.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/mysql/mysql-slow.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/rabbitmq
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/rabbitmq/rabbit at devstack-precise-hpcloud-az1-152021-sasl.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/rabbitmq/rabbit at devstack-precise-hpcloud-az1-152021.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/rabbitmq/startup_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-c-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-c-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-c-vol.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-ceilometer-acentral.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-ceilometer-acompute.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-ceilometer-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-ceilometer-collector.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-g-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-g-reg.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-h-api-cfn.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-h-api-cw.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-h-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-h-eng.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-horizon.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-key.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-cond.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-cpu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-crt.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-net.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-obj.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-n-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-s-account.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-s-container.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-s-object.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-s-proxy.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/screen-sysstat.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d/README.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d/cinder-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d/jenkins-sudo-grep.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.d/nova-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sudoers.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/syslog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/sysstat.dat.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/logs/tempest.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/testr_results.html.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-152021/12/subunit_log.txt.gz'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.