Open Stack

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

------------------------------------------
[...truncated 17416 lines...]
2013-09-02 06:06:23 
2013-09-02 06:06:23 [dashboard]
2013-09-02 06:06:23 # URL where to find the dashboard home page
2013-09-02 06:06:23 dashboard_url = http://127.0.0.1/
2013-09-02 06:06:23 
2013-09-02 06:06:23 # URL where to submit the login form
2013-09-02 06:06:23 login_url = http://127.0.0.1/auth/login/
2013-09-02 06:06:23 
2013-09-02 06:06:23 [scenario]
2013-09-02 06:06:23 # Directory containing image files
2013-09-02 06:06:23 img_dir = /opt/stack/new/devstack/files/images/cirros-0.3.1-x86_64-uec
2013-09-02 06:06:23 
2013-09-02 06:06:23 # AMI image file name
2013-09-02 06:06:23 ami_img_file = cirros-0.3.1-x86_64-blank.img
2013-09-02 06:06:23 
2013-09-02 06:06:23 # ARI image file name
2013-09-02 06:06:23 ari_img_file = cirros-0.3.1-x86_64-initrd
2013-09-02 06:06:23 
2013-09-02 06:06:23 # AKI image file name
2013-09-02 06:06:23 aki_img_file = cirros-0.3.1-x86_64-vmlinuz
2013-09-02 06:06:23 
2013-09-02 06:06:23 # ssh username for the image file
2013-09-02 06:06:23 ssh_user = cirros
2013-09-02 06:06:23 
2013-09-02 06:06:23 # specifies how many resources to request at once. Used for large operations
2013-09-02 06:06:23 # testing."
2013-09-02 06:06:23 large_ops_number = 0
2013-09-02 06:06:23 
2013-09-02 06:06:23 [cli]
2013-09-02 06:06:23 # Enable cli tests
2013-09-02 06:06:23 enabled = True
2013-09-02 06:06:23 # directory where python client binaries are located
2013-09-02 06:06:23 cli_dir = /usr/local/bin
2013-09-02 06:06:23 # Number of seconds to wait on a CLI timeout
2013-09-02 06:06:23 timeout = 15
2013-09-02 06:06:23 
2013-09-02 06:06:23 [service_available]
2013-09-02 06:06:23 # Whether or not cinder is expected to be available
2013-09-02 06:06:23 cinder = True
2013-09-02 06:06:23 # Whether or not neutron is expected to be available
2013-09-02 06:06:23 neutron = False
2013-09-02 06:06:23 # Whether or not glance is expected to be available
2013-09-02 06:06:23 glance = True
2013-09-02 06:06:23 # Whether or not swift is expected to be available
2013-09-02 06:06:23 swift = True
2013-09-02 06:06:23 # Whether or not nova is expected to be available
2013-09-02 06:06:24 nova = True
2013-09-02 06:06:24 # Whether or not Heat is expected to be available
2013-09-02 06:06:24 heat = True
2013-09-02 06:06:24 # Whether or not horizon is expected to be available
2013-09-02 06:06:24 horizon = True
2013-09-02 06:06:24 
2013-09-02 06:06:24 [stress]
2013-09-02 06:06:24 # Maximum number of instances to create during test
2013-09-02 06:06:24 max_instances = 32
2013-09-02 06:06:24 # Time (in seconds) between log file error checks
2013-09-02 06:06:24 log_check_interval = 60
2013-09-02 06:06:24 # The default number of threads created while stress test
2013-09-02 06:06:24 default_thread_number_per_action=4
2013-09-02 06:06:24 ++ IFS=' 	
2013-09-02 06:06:24 '
2013-09-02 06:06:24 ++ set +o errexit
2013-09-02 06:06:24 ++ init_tempest
2013-09-02 06:06:24 ++ local base_image_name=cirros-0.3.1-x86_64
2013-09-02 06:06:24 ++ local image_dir=/opt/stack/new/devstack/files/images/cirros-0.3.1-x86_64-uec
2013-09-02 06:06:24 ++ local kernel=/opt/stack/new/devstack/files/images/cirros-0.3.1-x86_64-uec/cirros-0.3.1-x86_64-vmlinuz
2013-09-02 06:06:24 ++ local ramdisk=/opt/stack/new/devstack/files/images/cirros-0.3.1-x86_64-uec/cirros-0.3.1-x86_64-initrd
2013-09-02 06:06:24 ++ local disk_image=/opt/stack/new/devstack/files/images/cirros-0.3.1-x86_64-uec/cirros-0.3.1-x86_64-blank.img
all create: /opt/stack/new/tempest/.tox/all
all inst: /opt/stack/new/tempest/.tox/dist/tempest-2013.2.a1660.ga87b64d.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/tmpWEmKPB
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/tmpDPsDbQ
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/tmpLVTUuL
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/tmpGDmm2p
======================================================================
FAIL: tempest.thirdparty.boto.test_ec2_instance_run.InstanceRunTest.test_run_stop_terminate_instance[gate,smoke]
tags: worker-0
----------------------------------------------------------------------
Empty attachments:
  stderr
  stdout

pythonlogging:'': {{{2013-09-02 06:18:33,636 state: pending}}}

Traceback (most recent call last):
  File "tempest/thirdparty/boto/test_ec2_instance_run.py", line 150, in test_run_stop_terminate_instance
    self.assertInstanceStateWait(instance, "running")
  File "tempest/thirdparty/boto/test.py", line 356, in assertInstanceStateWait
    state = self.waitInstanceState(lfunction, wait_for)
  File "tempest/thirdparty/boto/test.py", line 341, in waitInstanceState
    self.valid_instance_state)
  File "tempest/thirdparty/boto/test.py", line 332, in state_wait_gone
    self.assertIn(state, valid_set | self.gone_set)
  File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 328, in assertIn
    self.assertThat(haystack, Contains(needle))
  File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 417, in assertThat
    raise MismatchError(matchee, matcher, mismatch, verbose)
MismatchError: u'error' not in set(['paused', 'terminated', 'running', 'stopped', 'pending', '_GONE', 'stopping', 'shutting-down'])
======================================================================
FAIL: tempest.thirdparty.boto.test_ec2_instance_run.InstanceRunTest.test_run_stop_terminate_instance_with_tags[gate,smoke]
tags: worker-0
----------------------------------------------------------------------
Empty attachments:
  stderr
  stdout

pythonlogging:'': {{{2013-09-02 06:18:35,336 state: pending}}}

Traceback (most recent call last):
  File "tempest/thirdparty/boto/test_ec2_instance_run.py", line 175, in test_run_stop_terminate_instance_with_tags
    self.assertInstanceStateWait(instance, "running")
  File "tempest/thirdparty/boto/test.py", line 356, in assertInstanceStateWait
    state = self.waitInstanceState(lfunction, wait_for)
  File "tempest/thirdparty/boto/test.py", line 341, in waitInstanceState
    self.valid_instance_state)
  File "tempest/thirdparty/boto/test.py", line 332, in state_wait_gone
    self.assertIn(state, valid_set | self.gone_set)
  File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 328, in assertIn
    self.assertThat(haystack, Contains(needle))
  File "/usr/local/lib/python2.7/dist-packages/testtools/testcase.py", line 417, in assertThat
    raise MismatchError(matchee, matcher, mismatch, verbose)
MismatchError: u'error' not in set(['paused', 'terminated', 'running', 'stopped', 'pending', '_GONE', 'stopping', 'shutting-down'])
======================================================================
FAIL: setUpClass (tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestXML)
tags: worker-2
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/api/compute/images/test_list_image_filters.py", line 71, in setUpClass
    cls.tearDownClass()
  File "tempest/api/compute/base.py", line 114, in tearDownClass
    super(BaseComputeTest, cls).tearDownClass()
  File "tempest/test.py", line 144, in tearDownClass
    at_exit_set.remove(cls)
KeyError: <class 'tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestXML'>
======================================================================
FAIL: process-returncode
tags: worker-2
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
======================================================================
FAIL: tearDownClass (tempest.thirdparty.boto.test_ec2_instance_run.InstanceRunTest)
tags: worker-0
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/thirdparty/boto/test.py", line 270, in tearDownClass
    raise exceptions.TearDownException(num=fail_count)
TearDownException: 2 cleanUp operation failed
======================================================================
FAIL: setUpClass (tempest.whitebox.test_servers_whitebox.ServersWhiteboxTest)
tags: worker-0
----------------------------------------------------------------------
Traceback (most recent call last):
  File "tempest/whitebox/test_servers_whitebox.py", line 33, 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-0
----------------------------------------------------------------------
Binary content:
  traceback (test/plain; charset="utf8")
Ran 2501 tests in 1553.508s
FAILED (id=0, failures=7, skips=71)
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-200194
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/devstack-gate-cleanup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/devstack-gate-setup-host.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/devstack-gate-setup-workspace-new.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/devstacklog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/iptables.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/kern_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/localrc.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/mysql
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/mysql/error.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/mysql/mysql-slow.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/rabbitmq
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/rabbitmq/rabbit at devstack-precise-hpcloud-az1-200194-sasl.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/rabbitmq/rabbit at devstack-precise-hpcloud-az1-200194.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/rabbitmq/startup_log.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-c-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-c-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-c-vol.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-ceilometer-acentral.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-ceilometer-acompute.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-ceilometer-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-ceilometer-collector.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-g-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-g-reg.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-h-api-cfn.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-h-api-cw.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-h-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-h-eng.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-horizon.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-key.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-api.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-cond.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-cpu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-crt.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-net.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-obj.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-n-sch.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-s-account.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-s-container.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-s-object.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-s-proxy.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/screen-sysstat.txt.gz'
[SCP] Trying to create /srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d/90-cloudimg-ubuntu.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d/README.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d/cinder-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d/jenkins-sudo-grep.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.d/nova-rootwrap.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sudoers.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/syslog.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/sysstat.dat.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/logs/tempest.txt.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/testr_results.html.gz'
[SCP] uploading file: '/srv/static/logs/periodic/periodic-tempest-devstack-vm-all/devstack-precise-hpcloud-az1-200194/10/subunit_log.txt.gz'
[SCP] Connecting to static.openstack.org
[SCP] Copying console log.