06:30:41 Started by user anonymous
06:30:41 [EnvInject] - Loading node environment variables.
06:30:41 Building remotely on devstack_slave10 (devstack_slave) in workspace /home/jenkins/workspaces/workspace/dsvm-tempest-full
06:30:41 [dsvm-tempest-full] $ /bin/bash -xe /tmp/hudson262540342365515234.sh
06:30:41 + [[ ! -e devstack-gate ]]
06:30:41 + cd devstack-gate
06:30:41 + git remote set-url origin https://git.openstack.org/openstack-infra/devstack-gate
06:30:41 + git remote update
06:30:41 Fetching origin
06:30:41 + git reset --hard
06:30:41 HEAD is now at 88ae613 Merge "Capture apache configuration files"
06:30:41 + git clean -x -f
06:30:41 + git checkout master
06:30:41 Already on 'master'
06:30:41 Your branch is up-to-date with 'origin/master'.
06:30:41 + git reset --hard remotes/origin/master
06:30:41 HEAD is now at 88ae613 Merge "Capture apache configuration files"
06:30:41 + git clean -x -f
06:30:41 + cd ..
06:30:41 [dsvm-tempest-full] $ /bin/bash -xe /tmp/hudson356661767432926741.sh
06:30:41 + export TEMPEST_CONCURRENCY=1
06:30:41 + TEMPEST_CONCURRENCY=1
06:30:41 + '[' -z ']'
06:30:41 + export ZUUL_PROJECT=openstack-dev/sandbox
06:30:41 + ZUUL_PROJECT=openstack-dev/sandbox
06:30:41 + '[' -z ']'
06:30:41 + export ZUUL_BRANCH=master
06:30:41 + ZUUL_BRANCH=master
06:30:41 + export PYTHONUNBUFFERED=true
06:30:41 + PYTHONUNBUFFERED=true
06:30:41 + export DEVSTACK_GATE_TIMEOUT=480
06:30:41 + DEVSTACK_GATE_TIMEOUT=480
06:30:41 + export DEVSTACK_GATE_TEMPEST=1
06:30:41 + DEVSTACK_GATE_TEMPEST=1
06:30:41 + export RE_EXEC=true
06:30:41 + RE_EXEC=true
06:30:41 + export GIT_BASE=http://git.openstack.org
06:30:41 + GIT_BASE=http://git.openstack.org
06:30:41 + cp devstack-gate/devstack-vm-gate-wrap.sh ./safe-devstack-vm-gate-wrap.sh
06:30:41 + sed -i '/^export BASE=/a\
06:30:41 echo "Begin to unstack and clean, logging to $WORKSPACE/devstack-clean.txt"\
06:30:42 sudo -H -u stack stdbuf -oL -eL $BASE/new/devstack/unstack.sh &> $WORKSPACE/devstack-clean.txt\
06:30:42 sudo -H -u stack stdbuf -oL -eL $BASE/new/devstack/clean.sh &>> $WORKSPACE/devstack-clean.txt\
06:30:42 sudo mv $WORKSPACE/devstack-clean.txt $BASE/logs/\
06:30:42 echo "finish cleaning environment" \
06:30:42 # Pre clean\
06:30:42 ' safe-devstack-vm-gate-wrap.sh
06:30:42 + sed -i '/# Pre clean/a        for x in $( ps -ef | grep python | awk '\''{ print $2 }'\'' \) \
06:30:42 do \
06:30:42     sudo -H -u stack kill $x \
06:30:42 done \
06:30:42 ' safe-devstack-vm-gate-wrap.sh
06:30:42 + sed -i '/exit $RETVAL/i\
06:30:42 echo "backup log in workspace ..."\
06:30:42 if [ ! -d $WORKSPACE/$BUILD_NUMBER ];then\
06:30:42     mkdir -p $WORKSPACE/$BUILD_NUMBER/\
06:30:42 fi\
06:30:42 cp -r $WORKSPACE/logs/  $WORKSPACE/$BUILD_NUMBER/\
06:30:42 cp  $BASE/logs/*.txt   $WORKSPACE/$BUILD_NUMBER/\
06:30:42 echo "backup finished"\
06:30:42 ' safe-devstack-vm-gate-wrap.sh
06:30:42 + sed -i '/Running gate_hook/a\
06:30:42 sudo sh -c "sudo cat "$(cat /tmp/job_workspace)/emc_localrc" > /opt/stack/new/devstack/local.conf"\
06:30:42 ' safe-devstack-vm-gate-wrap.sh
06:30:42 + sed -i '/^# Run pre test hook/a\
06:30:42 sed -i "s/^BUILD_TIMEOUT.*/BUILD_TIMEOUT=1000/" /opt/stack/new/devstack/lib/tempest\
06:30:42 sed -i "s/ISOLATION:-.*/ISOLATION:-false}/" /opt/stack/new/devstack/lib/tempest\
06:30:42 ' safe-devstack-vm-gate-wrap.sh
06:30:42 + sed -i '/^# Run pre test hook/ased -i '\''s/^storage_protocol/storage_protocol=FC/'\'' /opt/stack/new/devstack/lib/tempest ' safe-devstack-vm-gate-wrap.sh
06:30:42 + export -f pre_test_hook
06:30:42 + echo /home/jenkins/workspaces/workspace/dsvm-tempest-full
06:30:42 + sed -i /tripleo/d ./safe-devstack-vm-gate-wrap.sh
06:30:42 + export -f post_test_hook
06:30:42 + ./safe-devstack-vm-gate-wrap.sh
06:30:42  * Stopping NTP server ntpd
06:30:42    ...done.
06:30:50  7 Jul 06:30:07 ntpdate[4635]: no server suitable for synchronization found
06:30:50  * Starting NTP server ntpd
06:30:50    ...done.
06:30:51 Begin to unstack and clean, logging to /home/jenkins/workspaces/workspace/dsvm-tempest-full/devstack-clean.txt
06:31:45 finish cleaning environment
06:31:47 Triggered by: https://review.openstack.org/ patchset 
06:31:47 Pipeline: 
06:31:47 Available disk space on this host:
06:31:47     Filesystem                   Size  Used Avail Use% Mounted on
06:31:47     /dev/mapper/ubuntu--vg-root  118G   12G  101G  11% /
06:31:47     none                         4.0K     0  4.0K   0% /sys/fs/cgroup
06:31:47     udev                         7.8G  4.0K  7.8G   1% /dev
06:31:47     tmpfs                        1.6G 1000K  1.6G   1% /run
06:31:47     none                         5.0M     0  5.0M   0% /run/lock
06:31:47     none                         7.9G   12K  7.9G   1% /run/shm
06:31:47     none                         100M     0  100M   0% /run/user
06:31:47     /dev/sda1                    228M   68M  149M  32% /boot
06:31:47 Setting up the host
06:31:47 ... this takes a few seconds (logs at logs/devstack-gate-setup-host.txt.gz)
06:32:55 Setting up the workspace
06:32:55 ... this takes 3 - 5 minutes (logs at logs/devstack-gate-setup-workspace-new.txt.gz)
06:34:54 Running pre_test_hook
06:34:54 + tsfilter pre_test_hook
06:34:54 + tee /home/jenkins/workspaces/workspace/dsvm-tempest-full/devstack-gate-pre-test-hook.txt
06:34:54 + pre_test_hook
06:34:54 + awk '
06:34:54     {
06:34:54         cmd ="date +\"%Y-%m-%d %H:%M:%S.%3N | \""
06:34:54         cmd | getline now
06:34:54         close("date +\"%Y-%m-%d %H:%M:%S.%3N | \"")
06:34:54         sub(/^/, now)
06:34:54         print
06:34:54         fflush()
06:34:54     }'
06:34:54 2014-07-07 06:34:11.118 | + echo 'enable volume driver and vendor'
06:34:54 2014-07-07 06:34:11.121 | enable volume driver and vendor
06:34:54 2014-07-07 06:34:11.124 | + sed -i '/^SWIFT_HASH/i\
06:34:54 2014-07-07 06:34:11.127 | TEMPEST_VOLUME_DRIVER=EMC\
06:34:54 2014-07-07 06:34:11.130 | TEMPEST_VOLUME_VENDOR=EMC\
06:34:54 2014-07-07 06:34:11.133 | TEMPEST_STORAGE_PROTOCOL=FC\
06:34:54 2014-07-07 06:34:11.136 | API_RATE_LIMIT=False\
06:34:54 2014-07-07 06:34:11.139 | ' /opt/stack/new/devstack-gate/devstack-vm-gate.sh
06:34:54 2014-07-07 06:34:11.142 | + echo 'enable EMC SMIS cinder driver'
06:34:54 2014-07-07 06:34:11.146 | enable EMC SMIS cinder driver
06:34:54 2014-07-07 06:34:11.149 | + bash /openstack/copy_vmax.sh
06:34:54 2014-07-07 06:34:11.168 | + sed -i '/Timeout/a\
06:34:54 2014-07-07 06:34:11.171 | iniset $TEMPEST_CONFIG compute build_interval 140\
06:34:54 2014-07-07 06:34:11.174 | ' /opt/stack/new/devstack/lib/tempest
06:34:54 2014-07-07 06:34:11.177 | + sed -i '/Timeout/a\
06:34:54 2014-07-07 06:34:11.180 | iniset $TEMPEST_CONFIG volume build_interval 140\
06:34:54 2014-07-07 06:34:11.183 | ' /opt/stack/new/devstack/lib/tempest
06:34:54 2014-07-07 06:34:11.186 | + sed -i s/500/2500/ /opt/stack/new/tempest/.testr.conf
06:34:54 2014-07-07 06:34:11.189 | + sed -i '/Timeout/a\
06:34:54 2014-07-07 06:34:11.192 | iniset $TEMPEST_CONFIG volume-feature-enabled backup false\
06:34:54 2014-07-07 06:34:11.195 | ' /opt/stack/new/devstack/lib/tempest
06:34:54 2014-07-07 06:34:11.199 | + sed -i '/Timeout/a\
06:34:54 2014-07-07 06:34:11.201 | iniset $TEMPEST_CONFIG volume allow_tenant_isolation false\
06:34:54 2014-07-07 06:34:11.204 | ' /opt/stack/new/devstack/lib/tempest
06:34:54 2014-07-07 06:34:11.207 | + echo 'avoiding to download fedora image'
06:34:54 2014-07-07 06:34:11.210 | avoiding to download fedora image
06:34:54 2014-07-07 06:34:11.213 | + sed -i 's/^ENABLED_SERVICES.*/ENABLED_SERVICES=c-api,c-bak,c-sch,c-vol,cinder,dstat,g-api,g-reg,horizon,key,mysql,n-api,n-cond,n-cpu,n-crt,n-net,n-obj,n-sch,rabbit,s-account,s-container,s-object,s-proxy,sahara,tempest,tr-api,tr-cond,tr-tmgr,trove/' /opt/stack/new/devstack-gate/devstack-vm-gate.sh
06:34:54 2014-07-07 06:34:11.216 | ++ grep demo
06:34:55 2014-07-07 06:34:11.219 | ++ keystone --os-username admin tenant-list
06:34:55 2014-07-07 06:34:11.221 | ++ grep -v alt
06:34:55 2014-07-07 06:34:11.224 | ++ awk '{print $2}'
06:34:55 2014-07-07 06:34:11.895 | Traceback (most recent call last):
06:34:55 2014-07-07 06:34:11.897 |   File "/usr/local/bin/keystone", line 6, in <module>
06:34:55 2014-07-07 06:34:11.900 |     from keystoneclient.shell import main
06:34:55 2014-07-07 06:34:11.903 |   File "/opt/stack/new/python-keystoneclient/keystoneclient/__init__.py", line 28, in <module>
06:34:55 2014-07-07 06:34:11.906 |     __version__ = pbr.version.VersionInfo('python-keystoneclient').version_string()
06:34:55 2014-07-07 06:34:11.909 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 78, in version_string
06:34:55 2014-07-07 06:34:11.912 |     for part in self.release_string().split('.'):
06:34:55 2014-07-07 06:34:11.915 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 70, in release_string
06:34:55 2014-07-07 06:34:11.918 |     self.release = self._get_version_from_pkg_resources()
06:34:55 2014-07-07 06:34:11.921 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 62, in _get_version_from_pkg_resources
06:34:55 2014-07-07 06:34:11.924 |     return packaging.get_version(self.package)
06:34:55 2014-07-07 06:34:11.926 |   File "/usr/local/lib/python2.7/dist-packages/pbr/packaging.py", line 877, in get_version
06:34:55 2014-07-07 06:34:11.928 |     raise Exception("Versioning for this project requires either an sdist"
06:34:55 2014-07-07 06:34:11.930 | Exception: Versioning for this project requires either an sdist tarball, or access to an upstream git repository. Are you sure that git is installed?
06:34:55 2014-07-07 06:34:11.939 | + nova --os-username admin quota-update --floating-ips 999
06:34:56 2014-07-07 06:34:12.344 | Traceback (most recent call last):
06:34:56 2014-07-07 06:34:12.347 |   File "/usr/local/bin/nova", line 6, in <module>
06:34:56 2014-07-07 06:34:12.350 |     from novaclient.shell import main
06:34:56 2014-07-07 06:34:12.353 |   File "/opt/stack/new/python-novaclient/novaclient/__init__.py", line 18, in <module>
06:34:56 2014-07-07 06:34:12.356 |     __version__ = pbr.version.VersionInfo('python-novaclient').version_string()
06:34:56 2014-07-07 06:34:12.359 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 78, in version_string
06:34:56 2014-07-07 06:34:12.362 |     for part in self.release_string().split('.'):
06:34:56 2014-07-07 06:34:12.365 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 70, in release_string
06:34:56 2014-07-07 06:34:12.368 |     self.release = self._get_version_from_pkg_resources()
06:34:56 2014-07-07 06:34:12.370 |   File "/usr/local/lib/python2.7/dist-packages/pbr/version.py", line 62, in _get_version_from_pkg_resources
06:34:56 2014-07-07 06:34:12.373 |     return packaging.get_version(self.package)
06:34:56 2014-07-07 06:34:12.376 |   File "/usr/local/lib/python2.7/dist-packages/pbr/packaging.py", line 877, in get_version
06:34:56 2014-07-07 06:34:12.379 |     raise Exception("Versioning for this project requires either an sdist"
06:34:56 2014-07-07 06:34:12.382 | Exception: Versioning for this project requires either an sdist tarball, or access to an upstream git repository. Are you sure that git is installed?
06:34:56 + sudo mv /home/jenkins/workspaces/workspace/dsvm-tempest-full/devstack-gate-pre-test-hook.txt /opt/stack/logs/
06:34:56 + set +o xtrace
06:34:56 Running gate_hook
06:34:56 Job timeout set to: 471 minutes
06:34:56 Running devstack
06:34:56 ... this takes 5 - 8 minutes (logs in logs/devstacklog.txt.gz)
06:46:37 Removing sudo privileges for devstack user
06:46:37 Running tempest smoke tests
06:46:38 smoke create: /opt/stack/new/tempest/.tox/smoke
06:46:39 smoke develop-inst: /opt/stack/new/tempest
06:49:19 smoke runtests: commands[0] | bash tools/pretty_tox.sh (?!.*\[.*\bslow\b.*\])((smoke)|(^tempest\.scenario)) --concurrency=1
06:49:19 WARNING:test command found but not installed in testenv
06:49:19   cmd: /bin/bash
06:49:19   env: /opt/stack/new/tempest/.tox/smoke
06:49:19 Maybe forgot to specify a dependency?
06:49:30 running testr
06:49:30 running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
06:49:30 OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
06:49:30 OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-2500} \
06:49:30 OS_TEST_LOCK_PATH=${OS_TEST_LOCK_PATH:-${TMPDIR:-'/tmp'}} \
06:49:30 ${PYTHON:-python} -m subunit.run discover -t ./ ${OS_TEST_PATH:-./tempest/test_discover} --list 
06:49:30 running=OS_STDOUT_CAPTURE=${OS_STDOUT_CAPTURE:-1} \
06:49:30 OS_STDERR_CAPTURE=${OS_STDERR_CAPTURE:-1} \
06:49:30 OS_TEST_TIMEOUT=${OS_TEST_TIMEOUT:-2500} \
06:49:30 OS_TEST_LOCK_PATH=${OS_TEST_LOCK_PATH:-${TMPDIR:-'/tmp'}} \
06:49:30 ${PYTHON:-python} -m subunit.run discover -t ./ ${OS_TEST_PATH:-./tempest/test_discover}  --load-list /tmp/tmpdF7Rgw
06:49:30 {0} setUpClass (tempest.api.baremetal.test_api_discovery.TestApiDiscovery) ... SKIPPED: TestApiDiscovery skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_chassis.TestChassis) ... SKIPPED: TestChassis skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_drivers.TestDrivers) ... SKIPPED: TestDrivers skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_nodes.TestNodes) ... SKIPPED: TestNodes skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_nodestates.TestNodeStates) ... SKIPPED: TestNodeStates skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_ports.TestPorts) ... SKIPPED: TestPorts skipped as Ironic is not available
06:49:30 {0} setUpClass (tempest.api.baremetal.test_ports_negative.TestPortsNegative) ... SKIPPED: TestPortsNegative skipped as Ironic is not available
06:49:32 
06:49:32 {0} tempest.api.compute.admin.test_quotas.QuotasAdminTestJSON.test_get_default_quotas [1.055066s] ... ok
06:49:34 {0} tempest.api.compute.admin.test_quotas.QuotasAdminTestXML.test_get_default_quotas [0.275565s] ... ok
06:49:42 {0} tempest.api.compute.admin.test_security_groups.SecurityGroupsTestAdminJSON.test_list_security_groups_list_all_tenants_filter [6.611822s] ... ok
06:49:47 {0} tempest.api.compute.admin.test_security_groups.SecurityGroupsTestAdminXML.test_list_security_groups_list_all_tenants_filter [4.637185s] ... ok
06:49:48 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestJSON.test_get_flavor [0.471133s] ... ok
06:49:49 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestJSON.test_list_flavors [1.064355s] ... ok
06:49:49 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestJSON.test_list_flavors_with_detail [0.102475s] ... ok
06:49:50 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestXML.test_get_flavor [0.517339s] ... ok
06:49:50 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestXML.test_list_flavors [0.058668s] ... ok
06:49:50 {0} tempest.api.compute.flavors.test_flavors.FlavorsV2TestXML.test_list_flavors_with_detail [0.058964s] ... ok
06:49:50 {0} setUpClass (tempest.api.compute.flavors.test_flavors.FlavorsV3Test) ... SKIPPED: FlavorsV3Test skipped as nova v3 api is not available
06:54:40 {0} tempest.api.compute.images.test_images_oneserver.ImagesOneServerTestJSON.test_create_delete_image [145.588720s] ... ok
07:01:49 {0} tempest.api.compute.images.test_images_oneserver.ImagesOneServerTestXML.test_create_delete_image [145.278521s] ... ok
07:04:10 {0} tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_get_image [0.411579s] ... ok
07:04:10 {0} tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_list_images [0.434733s] ... ok
07:04:11 {0} tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_list_images_with_detail [0.175713s] ... ok
07:04:11 {0} tempest.api.compute.images.test_list_images.ListImagesTestXML.test_get_image [0.406077s] ... ok
07:04:11 {0} tempest.api.compute.images.test_list_images.ListImagesTestXML.test_list_images [0.094269s] ... ok
07:04:12 {0} tempest.api.compute.images.test_list_images.ListImagesTestXML.test_list_images_with_detail [0.480545s] ... ok
07:04:14 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_create [1.470514s] ... ok
07:04:14 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_create_with_optional_arguments [0.765904s] ... ok
07:04:16 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_delete_when_peer_group_deleted [1.497270s] ... ok
07:04:17 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_list [0.846816s] ... ok
07:04:19 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestXML.test_security_group_rules_create [0.579790s] ... ok
07:04:19 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestXML.test_security_group_rules_create_with_optional_arguments [0.442182s] ... ok
07:04:20 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestXML.test_security_group_rules_delete_when_peer_group_deleted [0.622056s] ... ok
07:04:20 {0} tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestXML.test_security_group_rules_list [0.545583s] ... ok
07:04:23 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_duplicate [1.446477s] ... ok
07:04:23 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_invalid_from_port [0.190199s] ... ok
07:04:23 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_invalid_id [0.044908s] ... ok
07:04:24 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_invalid_ip_protocol [0.182456s] ... ok
07:04:24 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_invalid_port_range [0.417900s] ... ok
07:04:24 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_invalid_to_port [0.169265s] ... ok
07:04:24 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_create_security_group_rule_with_non_existent_id [0.031168s] ... ok
07:04:24 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestJSON.test_delete_security_group_rule_with_non_existent_id [0.024897s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_duplicate [0.832649s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_invalid_from_port [0.226115s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_invalid_id [0.022630s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_invalid_ip_protocol [0.140432s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_invalid_port_range [0.172303s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_invalid_to_port [0.142037s] ... ok
07:04:27 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_create_security_group_rule_with_non_existent_id [0.043349s] ... ok
07:04:28 {0} tempest.api.compute.security_groups.test_security_group_rules_negative.SecurityGroupRulesNegativeTestXML.test_delete_security_group_rule_with_non_existent_id [0.632120s] ... ok
07:04:30 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_security_group_create_get_delete [0.604705s] ... ok
07:04:31 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_security_groups_create_list_delete [0.933694s] ... ok
07:11:35 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_server_security_groups [424.879655s] ... ok
07:11:36 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_update_security_groups [0.299870s] ... ok
07:11:37 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestXML.test_security_group_create_get_delete [0.622591s] ... ok
07:11:38 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestXML.test_security_groups_create_list_delete [0.905780s] ... ok
07:18:42 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestXML.test_server_security_groups [424.051184s] ... ok
07:18:42 {0} tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestXML.test_update_security_groups [0.203189s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_delete_nonexistent_security_group [0.334175s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_delete_security_group_without_passing_id [0.017105s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_delete_the_default_security_group [0.165921s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_security_group_create_with_duplicate_name [0.297925s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_security_group_create_with_invalid_group_description [0.165234s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_security_group_create_with_invalid_group_name [0.144034s] ... ok
07:18:44 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_security_group_get_nonexistent_group [0.067611s] ... ok
07:18:45 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_update_non_existent_security_group [0.167504s] ... ok
07:18:45 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_update_security_group_with_invalid_sg_des [0.235029s] ... ok
07:18:45 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_update_security_group_with_invalid_sg_id [0.106218s] ... ok
07:18:45 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestJSON.test_update_security_group_with_invalid_sg_name [0.157373s] ... ok
07:18:46 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_delete_nonexistent_security_group [0.263963s] ... ok
07:18:46 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_delete_security_group_without_passing_id [0.015799s] ... ok
07:18:46 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_delete_the_default_security_group [0.065604s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_security_group_create_with_duplicate_name [0.298210s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_security_group_create_with_invalid_group_description [0.138187s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_security_group_create_with_invalid_group_name [0.215111s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_security_group_get_nonexistent_group [0.066378s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_update_non_existent_security_group [0.066954s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_update_security_group_with_invalid_sg_des [0.255876s] ... ok
07:18:47 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_update_security_group_with_invalid_sg_id [0.018836s] ... ok
07:18:48 {0} tempest.api.compute.security_groups.test_security_groups_negative.SecurityGroupsNegativeTestXML.test_update_security_group_with_invalid_sg_name [0.194577s] ... ok
07:18:48 {0} setUpClass (tempest.api.compute.servers.test_attach_interfaces.AttachInterfacesTestJSON) ... SKIPPED: Neutron is required
07:18:48 {0} setUpClass (tempest.api.compute.servers.test_attach_interfaces.AttachInterfacesTestXML) ... SKIPPED: Neutron is required
07:21:10 {0} tempest.api.compute.servers.test_create_server.ServersTestJSON.test_list_servers [0.068393s] ... ok
07:21:10 {0} tempest.api.compute.servers.test_create_server.ServersTestJSON.test_list_servers_with_detail [0.071893s] ... ok
07:21:10 {0} tempest.api.compute.servers.test_create_server.ServersTestJSON.test_verify_server_details [0.005643s] ... ok
07:25:53 {0} tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_list_servers [0.074260s] ... ok
07:25:53 {0} tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_list_servers_with_detail [0.074969s] ... ok
07:25:53 {0} tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_verify_server_details [0.003626s] ... ok
07:30:36 {0} tempest.api.compute.servers.test_create_server.ServersTestXML.test_list_servers [0.167985s] ... ok
07:30:36 {0} tempest.api.compute.servers.test_create_server.ServersTestXML.test_list_servers_with_detail [0.077742s] ... ok
07:30:36 {0} tempest.api.compute.servers.test_create_server.ServersTestXML.test_verify_server_details [0.005846s] ... ok
07:37:40 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_reboot_server_hard [141.127309s] ... ok
07:37:40 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_reboot_server_soft ... SKIPPED: Skipped until Bug: 1014647 is resolved.
07:40:02 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_rebuild_server [142.077581s] ... ok
07:44:44 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_resize_server_confirm [281.983287s] ... ok
07:54:08 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_resize_server_confirm_from_stopped [564.143077s] ... ok
08:01:12 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_reboot_server_hard [141.153487s] ... ok
08:01:12 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_reboot_server_soft ... SKIPPED: Skipped until Bug: 1014647 is resolved.
08:03:35 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_rebuild_server [142.315307s] ... ok
08:08:18 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_resize_server_confirm [283.065425s] ... ok
08:17:42 {0} tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_resize_server_confirm_from_stopped [564.259238s] ... ok
08:22:25 {0} tempest.api.compute.servers.test_server_addresses.ServerAddressesTestJSON.test_list_server_addresses [0.073094s] ... ok
08:22:25 {0} tempest.api.compute.servers.test_server_addresses.ServerAddressesTestJSON.test_list_server_addresses_by_network [0.272578s] ... ok
08:27:09 {0} tempest.api.compute.servers.test_server_addresses.ServerAddressesTestXML.test_list_server_addresses [0.075787s] ... ok
08:27:10 {0} tempest.api.compute.servers.test_server_addresses.ServerAddressesTestXML.test_list_server_addresses_by_network [0.407086s] ... ok
08:38:57 {0} tempest.api.compute.servers.test_server_rescue.ServerRescueTestJSON.test_rescue_unrescue_instance [281.775517s] ... ok
08:53:05 {0} tempest.api.compute.servers.test_server_rescue.ServerRescueTestXML.test_rescue_unrescue_instance [281.422600s] ... ok
08:57:48 {0} tempest.api.compute.test_quotas.QuotasTestJSON.test_compare_tenant_quotas_with_default_quotas [0.439971s] ... ok
08:57:48 {0} tempest.api.compute.test_quotas.QuotasTestJSON.test_get_default_quotas [0.027155s] ... ok
08:57:48 {0} tempest.api.compute.test_quotas.QuotasTestJSON.test_get_quotas [0.322719s] ... ok
08:57:49 {0} tempest.api.compute.test_quotas.QuotasTestXML.test_compare_tenant_quotas_with_default_quotas [0.306778s] ... ok
08:57:49 {0} tempest.api.compute.test_quotas.QuotasTestXML.test_get_default_quotas [0.024754s] ... ok
08:57:49 {0} tempest.api.compute.test_quotas.QuotasTestXML.test_get_quotas [0.050167s] ... ok
08:57:50 {0} setUpClass (tempest.api.compute.v3.admin.test_quotas.QuotasAdminV3Test) ... SKIPPED: QuotasAdminV3Test skipped as nova v3 api is not available
08:57:50 {0} setUpClass (tempest.api.compute.v3.images.test_images_oneserver.ImagesOneServerV3Test) ... SKIPPED: ImagesOneServerV3Test skipped as nova v3 api is not available
08:57:50 {0} setUpClass (tempest.api.compute.v3.servers.test_attach_interfaces.AttachInterfacesV3Test) ... SKIPPED: Neutron is required
08:57:51 {0} setUpClass (tempest.api.compute.v3.servers.test_create_server.ServersV3Test) ... SKIPPED: ServersV3Test skipped as nova v3 api is not available
08:57:51 {0} setUpClass (tempest.api.compute.v3.servers.test_create_server.ServersV3TestManualDisk) ... SKIPPED: ServersV3TestManualDisk skipped as nova v3 api is not available
08:57:51 {0} setUpClass (tempest.api.compute.v3.servers.test_server_actions.ServerActionsV3Test) ... SKIPPED: ServerActionsV3Test skipped as nova v3 api is not available
08:57:52 {0} setUpClass (tempest.api.compute.v3.servers.test_server_addresses.ServerAddressesV3Test) ... SKIPPED: ServerAddressesV3Test skipped as nova v3 api is not available
08:57:52 {0} setUpClass (tempest.api.compute.v3.servers.test_server_rescue.ServerRescueV3Test) ... SKIPPED: ServerRescueV3Test skipped as nova v3 api is not available
08:57:52 {0} setUpClass (tempest.api.compute.v3.test_quotas.QuotasV3Test) ... SKIPPED: QuotasV3Test skipped as nova v3 api is not available
09:02:35 {0} tempest.api.compute.volumes.test_volumes_get.VolumesGetTestJSON.test_volume_create_get_delete [282.048976s] ... ok
09:07:17 {0} tempest.api.compute.volumes.test_volumes_get.VolumesGetTestXML.test_volume_create_get_delete [281.935999s] ... ok
09:07:18 {0} tempest.api.data_processing.test_cluster_templates.ClusterTemplateTest.test_cluster_template_create [0.148257s] ... ok
09:07:18 {0} tempest.api.data_processing.test_cluster_templates.ClusterTemplateTest.test_cluster_template_delete [0.345579s] ... ok
09:07:19 {0} tempest.api.data_processing.test_cluster_templates.ClusterTemplateTest.test_cluster_template_get [0.180548s] ... ok
09:07:19 {0} tempest.api.data_processing.test_cluster_templates.ClusterTemplateTest.test_cluster_template_list [0.545677s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_external_hdfs_data_source_create [0.226252s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_external_hdfs_data_source_delete [0.069334s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_external_hdfs_data_source_get [0.051535s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_external_hdfs_data_source_list [0.045773s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_local_hdfs_data_source_create [0.038722s] ... ok
09:07:20 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_local_hdfs_data_source_delete [0.073619s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_local_hdfs_data_source_get [0.051457s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_local_hdfs_data_source_list [0.050240s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_swift_data_source_create [0.040927s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_swift_data_source_delete [0.069870s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_swift_data_source_get [0.053747s] ... ok
09:07:21 {0} tempest.api.data_processing.test_data_sources.DataSourceTest.test_swift_data_source_list [0.051868s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_internal_db_job_binary_create [0.057888s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_internal_db_job_binary_delete [0.073600s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_internal_db_job_binary_get [0.052522s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_internal_db_job_binary_list [0.049647s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_job_binary_get_data [0.061027s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_swift_job_binary_create [0.034677s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_swift_job_binary_delete [0.061152s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_swift_job_binary_get [0.049302s] ... ok
09:07:22 {0} tempest.api.data_processing.test_job_binaries.JobBinaryTest.test_swift_job_binary_list [0.046247s] ... ok
09:07:23 {0} tempest.api.data_processing.test_job_binary_internals.JobBinaryInternalTest.test_job_binary_internal_create [0.286515s] ... ok
09:07:23 {0} tempest.api.data_processing.test_job_binary_internals.JobBinaryInternalTest.test_job_binary_internal_delete [0.069200s] ... ok
09:07:23 {0} tempest.api.data_processing.test_job_binary_internals.JobBinaryInternalTest.test_job_binary_internal_get [0.051545s] ... ok
09:07:23 {0} tempest.api.data_processing.test_job_binary_internals.JobBinaryInternalTest.test_job_binary_internal_get_data [0.052048s] ... ok
09:07:23 {0} tempest.api.data_processing.test_job_binary_internals.JobBinaryInternalTest.test_job_binary_internal_list [0.047050s] ... ok
09:07:24 {0} tempest.api.data_processing.test_node_group_templates.NodeGroupTemplateTest.test_node_group_template_create [0.368069s] ... ok
09:07:24 {0} tempest.api.data_processing.test_node_group_templates.NodeGroupTemplateTest.test_node_group_template_delete [0.236729s] ... ok
09:07:25 {0} tempest.api.data_processing.test_node_group_templates.NodeGroupTemplateTest.test_node_group_template_get [0.082318s] ... ok
09:07:25 {0} tempest.api.data_processing.test_node_group_templates.NodeGroupTemplateTest.test_node_group_template_list [0.080034s] ... ok
09:07:26 {0} tempest.api.data_processing.test_plugins.PluginsTest.test_plugin_get [0.409421s] ... ok
09:07:26 {0} tempest.api.data_processing.test_plugins.PluginsTest.test_plugin_list [0.014310s] ... ok
09:07:28 {0} tempest.api.database.flavors.test_flavors.DatabaseFlavorsTest.test_compare_db_flavors_with_os [1.499712s] ... ok
09:07:28 {0} tempest.api.database.flavors.test_flavors.DatabaseFlavorsTest.test_get_db_flavor [0.165890s] ... ok
09:07:28 {0} tempest.api.database.flavors.test_flavors.DatabaseFlavorsTest.test_list_db_flavors [0.426687s] ... ok
09:07:29 {0} tempest.api.database.versions.test_versions.DatabaseVersionsTest.test_list_db_versions [0.177404s] ... ok
09:07:29 {0} tempest.api.identity.admin.test_services.ServicesTestJSON.test_create_get_delete_service [0.195624s] ... ok
09:07:30 {0} tempest.api.identity.admin.test_services.ServicesTestJSON.test_list_services [0.276458s] ... ok
09:07:30 {0} tempest.api.identity.admin.test_services.ServicesTestXML.test_create_get_delete_service [0.138012s] ... ok
09:07:31 {0} tempest.api.identity.admin.test_services.ServicesTestXML.test_list_services [0.278040s] ... ok
09:07:31 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_create_user [0.205752s] ... ok
09:07:32 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_create_user_with_enabled [0.187522s] ... ok
09:07:32 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_delete_user [0.274958s] ... ok
09:07:32 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_get_users [0.241465s] ... ok
09:07:33 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_update_user [0.461020s] ... ok
09:07:33 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_update_user_password [0.442926s] ... ok
09:07:33 {0} tempest.api.identity.admin.test_users.UsersTestJSON.test_user_authentication [0.458153s] ... ok
09:07:35 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_create_user [0.165253s] ... ok
09:07:35 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_create_user_with_enabled [0.163357s] ... ok
09:07:35 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_delete_user [0.307346s] ... ok
09:07:36 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_get_users [0.343910s] ... ok
09:07:36 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_update_user [0.367759s] ... ok
09:07:37 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_update_user_password [0.500350s] ... ok
09:07:37 {0} tempest.api.identity.admin.test_users.UsersTestXML.test_user_authentication [0.551556s] ... ok
09:07:39 {0} tempest.api.identity.admin.v3.test_credentials.CredentialsTestJSON.test_credentials_create_get_update_delete [0.161361s] ... ok
09:07:39 {0} tempest.api.identity.admin.v3.test_credentials.CredentialsTestJSON.test_credentials_list_delete [0.166807s] ... ok
09:07:40 {0} tempest.api.identity.admin.v3.test_credentials.CredentialsTestXML.test_credentials_create_get_update_delete [0.216046s] ... ok
09:07:40 {0} tempest.api.identity.admin.v3.test_credentials.CredentialsTestXML.test_credentials_list_delete [0.167591s] ... ok
09:07:41 {0} tempest.api.identity.admin.v3.test_domains.DomainsTestJSON.test_create_update_delete_domain [0.400529s] ... ok
09:07:42 {0} tempest.api.identity.admin.v3.test_domains.DomainsTestJSON.test_list_domains [0.532945s] ... ok
09:07:43 {0} tempest.api.identity.admin.v3.test_domains.DomainsTestXML.test_create_update_delete_domain [0.470253s] ... ok
09:07:43 {0} tempest.api.identity.admin.v3.test_domains.DomainsTestXML.test_list_domains [0.526635s] ... ok
09:07:44 {0} tempest.api.identity.admin.v3.test_endpoints.EndPointsTestJSON.test_update_endpoint [0.155855s] ... ok
09:07:45 {0} tempest.api.identity.admin.v3.test_endpoints.EndPointsTestXML.test_update_endpoint [0.220103s] ... ok
09:07:46 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestJSON.test_group_create_update_get [0.343623s] ... ok
09:07:47 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestJSON.test_group_users_add_list_delete [1.021091s] ... ok
09:07:47 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestJSON.test_list_user_groups [0.519896s] ... ok
09:07:48 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestXML.test_group_create_update_get [0.442047s] ... ok
09:07:49 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestXML.test_group_users_add_list_delete [1.012468s] ... ok
09:07:50 {0} tempest.api.identity.admin.v3.test_groups.GroupsV3TestXML.test_list_user_groups [0.618396s] ... ok
09:07:50 {0} tempest.api.identity.admin.v3.test_policies.PoliciesTestJSON.test_create_update_delete_policy [0.318250s] ... ok
09:07:50 {0} tempest.api.identity.admin.v3.test_policies.PoliciesTestJSON.test_list_policies [0.227846s] ... ok
09:07:51 {0} tempest.api.identity.admin.v3.test_policies.PoliciesTestXML.test_create_update_delete_policy [0.343345s] ... ok
09:07:51 {0} tempest.api.identity.admin.v3.test_policies.PoliciesTestXML.test_list_policies [0.227593s] ... ok
09:07:52 {0} tempest.api.identity.admin.v3.test_regions.RegionsTestJSON.test_create_region_with_specific_id [0.097765s] ... ok
09:07:53 {0} tempest.api.identity.admin.v3.test_regions.RegionsTestXML.test_create_region_with_specific_id [0.095092s] ... ok
09:07:54 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_grant_list_revoke_role_to_group_on_domain [0.133504s] ... ok
09:07:55 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_grant_list_revoke_role_to_group_on_project [0.514757s] ... ok
09:07:55 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_grant_list_revoke_role_to_user_on_domain [0.140975s] ... ok
09:07:55 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_grant_list_revoke_role_to_user_on_project [0.149445s] ... ok
09:07:55 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_role_create_update_get_list [0.148595s] ... ok
09:07:57 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestXML.test_grant_list_revoke_role_to_group_on_domain [0.133882s] ... ok
09:07:57 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestXML.test_grant_list_revoke_role_to_group_on_project [0.582859s] ... ok
09:07:57 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestXML.test_grant_list_revoke_role_to_user_on_domain [0.147359s] ... ok
09:07:57 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestXML.test_grant_list_revoke_role_to_user_on_project [0.147149s] ... ok
09:07:58 {0} tempest.api.identity.admin.v3.test_roles.RolesV3TestXML.test_role_create_update_get_list [0.163507s] ... ok
09:07:59 {0} tempest.api.identity.admin.v3.test_tokens.TokensV3TestJSON.test_tokens [0.570265s] ... ok
09:08:00 {0} tempest.api.identity.admin.v3.test_tokens.TokensV3TestXML.test_tokens [0.642503s] ... ok
09:08:02 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_get_trusts_all [1.278612s] ... ok
09:08:03 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_get_trusts_query [0.985794s] ... ok
09:08:04 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_trust_expire [1.140461s] ... ok
09:08:05 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_trust_expire_invalid [0.877894s] ... ok
09:08:06 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_trust_impersonate [1.151578s] ... ok
09:08:07 {0} tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_trust_noimpersonate [1.118453s] ... ok
09:08:07 {0} setUpClass (tempest.api.network.admin.test_agent_management.AgentManagementTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_agent_management.AgentManagementTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_dhcp_agent_scheduler.DHCPAgentSchedulersTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_dhcp_agent_scheduler.DHCPAgentSchedulersTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_floating_ips_admin_actions.FloatingIPAdminTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_floating_ips_admin_actions.FloatingIPAdminTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_l3_agent_scheduler.L3AgentSchedulerTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_l3_agent_scheduler.L3AgentSchedulerTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_lbaas_agent_scheduler.LBaaSAgentSchedulerTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_lbaas_agent_scheduler.LBaaSAgentSchedulerTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_load_balancer_admin_actions.LoadBalancerAdminTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.admin.test_load_balancer_admin_actions.LoadBalancerAdminTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_allowed_address_pair.AllowedAddressPairTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_allowed_address_pair.AllowedAddressPairTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_extensions.ExtensionsTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_extensions.ExtensionsTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_extra_dhcp_options.ExtraDHCPOptionsTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_floating_ips.FloatingIPTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_floating_ips.FloatingIPTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_fwaas_extensions.FWaaSExtensionTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_fwaas_extensions.FWaaSExtensionTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_load_balancer.LoadBalancerTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_load_balancer.LoadBalancerTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_metering_extensions.MeteringJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_metering_extensions.MeteringXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.BulkNetworkOpsTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.BulkNetworkOpsTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.NetworksIpV6TestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.NetworksIpV6TestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.NetworksTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks.NetworksTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks_negative.NetworksNegativeTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_networks_negative.NetworksNegativeTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsAdminExtendedAttrsIpV6TestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsAdminExtendedAttrsIpV6TestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsAdminExtendedAttrsTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsAdminExtendedAttrsTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsIpV6TestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsIpV6TestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_ports.PortsTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_routers.RoutersTest) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_routers_negative.RoutersNegativeTest) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_security_groups.SecGroupTest) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_security_groups.SecGroupTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_security_groups_negative.NegativeSecGroupTest) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_security_groups_negative.NegativeSecGroupTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_service_type_management.ServiceTypeManagementTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_service_type_management.ServiceTypeManagementTestXML) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_vpnaas_extensions.VPNaaSTestJSON) ... SKIPPED: Neutron support is required
09:08:07 {0} setUpClass (tempest.api.network.test_vpnaas_extensions.VPNaaSTestXML) ... SKIPPED: Neutron support is required
09:08:09 {0} tempest.api.object_storage.test_account_quotas.AccountQuotasTest.test_admin_modify_quota [0.154928s] ... ok
09:08:10 {0} tempest.api.object_storage.test_account_quotas.AccountQuotasTest.test_upload_valid_object [0.096008s] ... ok
09:08:12 {0} tempest.api.object_storage.test_account_quotas_negative.AccountQuotasNegativeTest.test_upload_large_object ... SKIPPED: Skipped until Bug: 1310597 is resolved.
09:08:12 {0} tempest.api.object_storage.test_account_quotas_negative.AccountQuotasNegativeTest.test_user_modify_quota [0.078294s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_account_metadata [0.205718s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers [0.029611s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_end_marker [0.043879s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_format_json [0.022739s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_format_xml [0.025757s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_limit [0.062588s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_limit_and_end_marker [0.024356s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_limit_and_marker [0.223457s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_limit_and_marker_and_end_marker [0.023170s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_marker [0.041155s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_containers_with_marker_and_end_marker [0.025275s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_extensions [0.014812s] ... ok
09:08:14 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_no_account_metadata [0.027290s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_list_no_containers [0.902726s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_update_account_metadata_with_create_and_delete_metadata [0.090498s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_update_account_metadata_with_create_matadata_key [0.049662s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_update_account_metadata_with_create_metadata [0.060734s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_update_account_metadata_with_delete_matadata [0.078036s] ... ok
09:08:15 {0} tempest.api.object_storage.test_account_services.AccountTest.test_update_account_metadata_with_delete_matadata_key [0.065795s] ... ok
09:08:18 {0} tempest.api.object_storage.test_container_acl.ObjectTestACLs.test_read_object_with_rights [0.458027s] ... ok
09:08:18 {0} tempest.api.object_storage.test_container_acl.ObjectTestACLs.test_write_object_with_rights [0.147225s] ... ok
09:08:20 {0} tempest.api.object_storage.test_container_acl_negative.ObjectACLsNegativeTest.test_delete_object_without_write_rights [0.492295s] ... ok
09:08:20 {0} tempest.api.object_storage.test_container_acl_negative.ObjectACLsNegativeTest.test_read_object_without_rights [0.158024s] ... ok
09:08:20 {0} tempest.api.object_storage.test_container_acl_negative.ObjectACLsNegativeTest.test_write_object_without_rights [0.118419s] ... ok
09:08:20 {0} tempest.api.object_storage.test_container_acl_negative.ObjectACLsNegativeTest.test_write_object_without_write_rights [0.124804s] ... ok
09:08:22 {0} tempest.api.object_storage.test_container_quotas.ContainerQuotasTest.test_upload_large_object [0.356588s] ... ok
09:08:22 {0} tempest.api.object_storage.test_container_quotas.ContainerQuotasTest.test_upload_too_many_objects [0.297463s] ... ok
09:08:22 {0} tempest.api.object_storage.test_container_quotas.ContainerQuotasTest.test_upload_valid_object [0.196740s] ... ok
09:08:23 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container [0.280255s] ... ok
09:08:23 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container_overwrite [0.121940s] ... ok
09:08:23 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container_with_metadata_key [0.108198s] ... ok
09:08:23 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container_with_metadata_value [0.112291s] ... ok
09:08:23 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container_with_remove_metadata_key [0.139618s] ... ok
09:08:24 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_create_container_with_remove_metadata_value [0.137478s] ... ok
09:08:24 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_delete_container [0.167580s] ... ok
09:08:24 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents [0.213027s] ... ok
09:08:24 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_delimiter [0.166570s] ... ok
09:08:24 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_end_marker [0.162057s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_format_json [0.167991s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_format_xml [0.166235s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_limit [0.162052s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_marker [0.159571s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_no_object [0.104303s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_path [0.172548s] ... ok
09:08:25 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_contents_with_prefix [0.168490s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_container_metadata [0.118786s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_list_no_container_metadata [0.100485s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_update_container_metadata_with_create_and_delete_matadata [0.123836s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_update_container_metadata_with_create_matadata_key [0.119630s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_update_container_metadata_with_create_metadata [0.115355s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_update_container_metadata_with_delete_metadata [0.114366s] ... ok
09:08:26 {0} tempest.api.object_storage.test_container_services.ContainerTest.test_update_container_metadata_with_delete_metadata_key [0.122503s] ... ok
09:08:27 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_copy_object_2d_way [0.111714s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_copy_object_across_containers [0.200977s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_copy_object_in_same_container [0.109077s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_copy_object_to_itself [0.093478s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object [0.041128s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_if_match [0.044446s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_if_modified_since [0.046550s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_if_unmodified_since [0.051509s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_metadata [0.042564s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_range [0.046902s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_x_newest [0.053444s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_get_object_with_x_object_manifest [0.370236s] ... ok
09:08:28 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_list_no_object_metadata [0.043393s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_list_object_metadata [0.051557s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_list_object_metadata_with_x_object_manifest [0.297665s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_update_object_metadata [0.069649s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_update_object_metadata_with_create_and_remove_metadata [0.076588s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_update_object_metadata_with_x_object_manifest [0.346276s] ... ok
09:08:29 {0} tempest.api.object_storage.test_object_services.ObjectTest.test_update_object_metadata_with_x_remove_object_metakey [0.074683s] ... ok
09:08:32 {0} tempest.api.object_storage.test_object_services.PublicObjectTest.test_access_public_container_object_without_using_creds [0.447392s] ... ok
09:08:32 {0} tempest.api.object_storage.test_object_services.PublicObjectTest.test_access_public_object_with_another_user_creds [0.372287s] ... ok
09:08:33 {0} tempest.api.object_storage.test_object_version.ContainerTest.test_versioned_container [0.557508s] ... ok
09:08:34 {0} setUpClass (tempest.api.orchestration.stacks.test_stacks.StacksTestJSON) ... SKIPPED: Heat support is required
09:08:34 {0} setUpClass (tempest.api.queuing.test_claims.TestClaims) ... SKIPPED: Marconi support is required
09:08:34 {0} setUpClass (tempest.api.queuing.test_messages.TestMessages) ... SKIPPED: Marconi support is required
09:08:34 {0} setUpClass (tempest.api.queuing.test_queues.TestManageQueue) ... SKIPPED: Marconi support is required
09:08:34 {0} setUpClass (tempest.api.queuing.test_queues.TestQueues) ... SKIPPED: Marconi support is required
09:08:34 {0} setUpClass (tempest.api.volume.admin.test_multi_backend.VolumeMultiBackendTest) ... SKIPPED: Cinder multi-backend feature disabled
09:13:16 {0} tempest.api.volume.admin.test_volume_types.VolumeTypesTest.test_create_get_delete_volume_with_volume_type_and_extra_specs [281.281135s] ... ok
09:13:16 {0} tempest.api.volume.admin.test_volume_types.VolumeTypesTest.test_volume_type_create_get_delete [0.140057s] ... ok
09:13:17 {0} tempest.api.volume.admin.test_volume_types.VolumeTypesTest.test_volume_type_encryption_create_get_delete [0.287559s] ... ok
09:13:17 {0} tempest.api.volume.admin.test_volume_types.VolumeTypesTest.test_volume_type_list [0.024885s] ... ok
09:13:18 {0} tempest.api.volume.admin.test_volume_types_extra_specs.VolumeTypesExtraSpecsTest.test_volume_type_extra_spec_create_get_delete [0.121501s] ... ok
09:13:18 {0} tempest.api.volume.admin.test_volume_types_extra_specs.VolumeTypesExtraSpecsTest.test_volume_type_extra_specs_list [0.072949s] ... ok
09:13:18 {0} setUpClass (tempest.api.volume.admin.test_volumes_backup.VolumesBackupsTest) ... SKIPPED: Cinder backup feature disabled
09:18:02 {0} tempest.api.volume.test_volumes_actions.VolumesActionsTest.test_attach_detach_volume_to_instance [0.990750s] ... ok
09:27:27 {0} tempest.api.volume.test_volumes_actions.VolumesActionsTestXML.test_attach_detach_volume_to_instance [0.874866s] ... ok
09:41:31 {0} tempest.api.volume.test_volumes_get.VolumesGetTest.test_volume_create_get_update_delete [562.339432s] ... ok
09:50:54 {0} tempest.api.volume.test_volumes_get.VolumesGetTest.test_volume_create_get_update_delete_from_image [562.399644s] ... ok
10:00:16 {0} tempest.api.volume.test_volumes_get.VolumesGetTestXML.test_volume_create_get_update_delete [562.228623s] ... ok
10:09:39 {0} tempest.api.volume.test_volumes_get.VolumesGetTestXML.test_volume_create_get_update_delete_from_image [562.392827s] ... ok
10:16:41 {0} tempest.api.volume.test_volumes_list.VolumeListTestXML.test_volume_list [0.040235s] ... ok
10:30:44 {0} tempest.api.volume.test_volumes_list.VolumesListTest.test_volume_list [0.038538s] ... ok
10:44:48 {0} tempest.api.volume.v2.test_volumes_list.VolumesV2ListTestJSON.test_volume_list [0.119531s] ... ok
10:58:51 {0} tempest.api.volume.v2.test_volumes_list.VolumesV2ListTestXML.test_volume_list [0.036525s] ... ok
11:05:53 {0} setUpClass (tempest.cli.simple_read_only.test_neutron.SimpleReadOnlyNeutronClientTest) ... SKIPPED: Skipping all Neutron cli tests because it is not available
11:05:56 {0} tempest.scenario.test_aggregates_basic_ops.TestAggregatesBasicOps.test_aggregate_basic_ops [1.645672s] ... ok
11:05:58 {0} setUpClass (tempest.scenario.test_baremetal_basic_ops.BaremetalBasicOpsPXESSH) ... SKIPPED: Ironic not available or Ironic compute driver not enabled
11:06:11 {0} tempest.scenario.test_dashboard_basic_ops.TestDashboardBasicOps.test_basic_scenario [10.806610s] ... ok
11:20:31 {0} tempest.scenario.test_encrypted_cinder_volumes.TestEncryptedCinderVolumes.test_encrypted_cinder_volumes_cryptsetup [856.716857s] ... ok
11:34:45 {0} tempest.scenario.test_encrypted_cinder_volumes.TestEncryptedCinderVolumes.test_encrypted_cinder_volumes_luks [853.242237s] ... ok
11:34:47 {0} tempest.scenario.test_large_ops.TestLargeOpsScenario.test_large_ops_scenario_1 [0.007099s] ... ok
11:34:47 {0} tempest.scenario.test_large_ops.TestLargeOpsScenario.test_large_ops_scenario_2 [0.004117s] ... ok
11:34:47 {0} tempest.scenario.test_large_ops.TestLargeOpsScenario.test_large_ops_scenario_3 [0.004072s] ... ok
11:34:49 {0} setUpClass (tempest.scenario.test_load_balancer_basic.TestLoadBalancerBasic) ... SKIPPED: Neutron not available
11:51:30 {0} tempest.scenario.test_minimum_basic.TestMinimumBasicScenario.test_minimum_basic_scenario [998.998570s] ... ok
11:51:32 {0} setUpClass (tempest.scenario.test_network_advanced_server_ops.TestNetworkAdvancedServerOps) ... SKIPPED: Neutron not available
11:51:34 {0} setUpClass (tempest.scenario.test_network_basic_ops.TestNetworkBasicOps) ... SKIPPED: Neutron not available
11:51:37 {0} setUpClass (tempest.scenario.test_security_groups_basic_ops.TestSecurityGroupsBasicOps) ... SKIPPED: Neutron not available
12:01:04 {0} tempest.scenario.test_server_advanced_ops.TestServerAdvancedOps.test_resize_server_confirm [564.258257s] ... ok
12:15:08 {0} tempest.scenario.test_server_advanced_ops.TestServerAdvancedOps.test_server_sequence_suspend_resume [844.546271s] ... ok
12:19:57 {0} tempest.scenario.test_server_basic_ops.TestServerBasicOps.test_server_basicops [287.150185s] ... ok
12:31:58 {0} tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern [718.118662s] ... ok
12:32:00 {0} tempest.scenario.test_stamp_pattern.TestStampPattern.test_stamp_pattern ... SKIPPED: Skipped until Bug: 1205344 is resolved.
12:32:02 {0} tempest.scenario.test_swift_basic_ops.TestSwiftBasicOps.test_swift_basic_ops [0.457007s] ... ok
13:00:27 {0} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_volume_boot_pattern [1702.577251s] ... ok
13:28:55 {0} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPatternV2.test_volume_boot_pattern [1706.667856s] ... ok
13:28:56 Slowest Tests
13:28:56 Test id                                                                                                                                   Runtime (s)
13:28:56 ----------------------------------------------------------------------------------------------------------------------------------------  -----------
13:28:56 tempest.scenario.test_volume_boot_pattern.TestVolumeBootPatternV2.test_volume_boot_pattern[compute,image,volume]                          1706.668
13:28:56 tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_volume_boot_pattern[compute,image,volume]                            1702.577
13:28:56 tempest.scenario.test_minimum_basic.TestMinimumBasicScenario.test_minimum_basic_scenario[compute,image,network,volume]                     998.999
13:28:56 tempest.scenario.test_encrypted_cinder_volumes.TestEncryptedCinderVolumes.test_encrypted_cinder_volumes_cryptsetup[compute,image,volume]   856.717
13:28:56 tempest.scenario.test_encrypted_cinder_volumes.TestEncryptedCinderVolumes.test_encrypted_cinder_volumes_luks[compute,image,volume]         853.242
13:28:56 tempest.scenario.test_server_advanced_ops.TestServerAdvancedOps.test_server_sequence_suspend_resume[compute]                               844.546
13:28:56 tempest.scenario.test_snapshot_pattern.TestSnapshotPattern.test_snapshot_pattern[compute,image,network]                                    718.119
13:28:56 tempest.api.compute.servers.test_server_actions.ServerActionsTestXML.test_resize_server_confirm_from_stopped[gate,smoke]                   564.259
13:28:56 tempest.scenario.test_server_advanced_ops.TestServerAdvancedOps.test_resize_server_confirm[compute]                                        564.258
13:28:56 tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_resize_server_confirm_from_stopped[gate,smoke]                  564.143
13:28:56 
13:28:56 ======
13:28:56 Totals
13:28:56 ======
13:28:56 Run: 396 in 15686.733235 sec.
13:28:56  - Passed: 309
13:28:56  - Skipped: 87
13:28:56  - Failed: 0
13:28:56 
13:28:56 ==============
13:28:56 Worker Balance
13:28:56 ==============
13:28:56  - Worker 0 (396 tests) => 6:39:25.603770s
13:28:56 ___________________________________ summary ____________________________________
13:28:56   smoke: commands succeeded
13:28:56   congratulations :)
13:28:56 Running log checker
13:28:56 Checking logs...
13:28:57 
13:28:57 Log File Has Errors: g-api
13:28:57 *** Not Whitelisted *** 2014-07-07 06:39:07.025 6516 ERROR glance.store.sheepdog [-] Error in store configuration: [Errno 2] No such file or directory
13:28:57 *** Not Whitelisted *** 2014-07-07 06:39:12.243 6587 ERROR swiftclient [-] Container HEAD failed: http://127.0.0.1:8080/v1/AUTH_83240e03af6249bf8aea578492732733/glance 404 Not Found
13:28:57 Logs have errors
13:28:57 ok
13:28:57 Running post_test_hook
13:28:57 + tsfilter post_test_hook
13:28:57 + tee /home/jenkins/workspaces/workspace/dsvm-tempest-full/devstack-gate-post-test-hook.txt
13:28:57 + post_test_hook
13:28:57 + awk '
13:28:57     {
13:28:57         cmd ="date +\"%Y-%m-%d %H:%M:%S.%3N | \""
13:28:57         cmd | getline now
13:28:57         close("date +\"%Y-%m-%d %H:%M:%S.%3N | \"")
13:28:57         sub(/^/, now)
13:28:57         print
13:28:57         fflush()
13:28:57     }'
13:28:57 2014-07-07 13:28:13.855 | + echo 'nothing in post_test_hook'
13:28:57 2014-07-07 13:28:13.859 | nothing in post_test_hook
13:28:57 + RETVAL=0
13:28:57 + sudo mv /home/jenkins/workspaces/workspace/dsvm-tempest-full/devstack-gate-post-test-hook.txt /opt/stack/logs/
13:28:57 + set +o pipefail
13:28:57 + set +o xtrace
13:28:57 Cleaning up host
13:28:57 ... this takes 3 - 4 minutes (logs at logs/devstack-gate-cleanup-host.txt.gz)
13:29:21 backup log in workspace ...
13:29:21 backup finished
13:29:31 Process leaked file descriptors. See http://wiki.jenkins-ci.org/display/JENKINS/Spawning+processes+from+build for more information
13:29:31 [dsvm-tempest-full] $ /bin/sh /tmp/hudson8269720433352556394.sh
13:29:31 Performing Post build task...
13:29:31 Match found for : : True
13:29:31 Logical operation result is TRUE
13:29:31 Running script  : 
13:29:31 [dsvm-tempest-full] $ /bin/sh -xe /tmp/hudson6656227832097789099.sh
13:29:31 POST BUILD TASK : SUCCESS
13:29:31 END OF POST BUILD TASK : 0
13:29:31 Finished: SUCCESS