2020-05-28 21:03:20.947 7 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:20.948 7 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:20.948 7 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils [-] Unexpected exception in CLI: rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "<decorator-gen-16>", line 2, in destroy
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/envutils.py", line 135, in default_from_global
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "<decorator-gen-15>", line 2, in destroy
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/deployment.py", line 154, in destroy
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     api.deployment.destroy(deployment=deployment)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 115, in destroy
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     deploy = objects.Deployment.get(deployment)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/deploy.py", line 124, in get
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     return Deployment(env_mgr.EnvManager.get(deploy))
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/env/env_mgr.py", line 212, in get
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     return cls(db.env_get(uuid_or_name))
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 518, in env_get
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2020-05-28 21:03:23.180 7 ERROR rally.cli.cliutils 
2020-05-28 21:03:24.787 9 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:24.788 9 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:24.788 9 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:29.063 11 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:29.063 11 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:29.064 11 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:33.345 14 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:33.345 14 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:33.345 14 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:34.786 17 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:34.787 17 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:34.787 17 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils [-] Unexpected exception in CLI: rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "<decorator-gen-67>", line 2, in delete_verifier
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/verify.py", line 234, in delete_verifier
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     api.verifier.delete(verifier_id=verifier_id,
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 690, in delete
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     verifier = self._get(verifier_id)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 664, in _get
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     return objects.Verifier.get(verifier_id)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/verifier.py", line 69, in get
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     return cls(db.verifier_get(verifier_id))
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 667, in verifier_get
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     return _verifier_get(session, verifier_id)
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 676, in _verifier_get
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2020-05-28 21:03:36.925 17 ERROR rally.cli.cliutils 
2020-05-28 21:03:38.489 19 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:38.489 19 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:38.489 19 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:40.637 19 INFO rally.api [-] Creating verifier 'opnfv-tempest'.
2020-05-28 21:03:40.744 19 RALLYDEBUG rally.verification.manager [-] Cloning verifier repo from /src/tempest into /root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/repo.
2020-05-28 21:03:40.987 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'Cloning into '/root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/repo'...
done.
'
2020-05-28 21:03:41.002 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'heads/master
'
2020-05-28 21:03:41.029 19 RALLYDEBUG rally.verification.manager [-] Checking system-wide packages for verifier.
2020-05-28 21:03:41.078 19 RALLYDEBUG rally.plugins.verification.testr [-] Initializing testr.
2020-05-28 21:03:41.861 19 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=1f95ccd7-57de-4d0a-9af6-71ac3735569e) has been successfully created!
2020-05-28 21:03:43.510 26 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:43.511 26 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:43.511 26 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:53.184 29 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:03:53.258 29 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:03:53.258 29 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:03:55.523 29 INFO rally.api [-] Configuring verifier 'opnfv-tempest' (UUID=1f95ccd7-57de-4d0a-9af6-71ac3735569e) for deployment 'opnfv-rally' (UUID=260789ef-e52d-498b-bcb3-deaed7b6ee47).
2020-05-28 21:03:55.957 29 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=1f95ccd7-57de-4d0a-9af6-71ac3735569e) has been successfully configured for deployment 'opnfv-rally' (UUID=260789ef-e52d-498b-bcb3-deaed7b6ee47)!
2020-05-28 21:04:05.159 34 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:04:05.159 34 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:04:05.159 34 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:04:07.329 34 INFO rally.api [-] Starting verification (UUID=c43b59d2-e2dc-4e16-a4a2-fc4238562cbe) for deployment 'opnfv-rally' (UUID=260789ef-e52d-498b-bcb3-deaed7b6ee47) by verifier 'opnfv-tempest' (UUID=1f95ccd7-57de-4d0a-9af6-71ac3735569e).
2020-05-28 21:04:07.971 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' from 'DEFAULT' section is not configured.
2020-05-28 21:04:07.974 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/for-deployment-260789ef-e52d-498b-bcb3-deaed7b6ee47/tempest.log' to option 'log_file'.
2020-05-28 21:04:07.974 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' is configured. log_file = /root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/for-deployment-260789ef-e52d-498b-bcb3-deaed7b6ee47/tempest.log
2020-05-28 21:04:07.974 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' from 'oslo_concurrency' section is not configured.
2020-05-28 21:04:07.974 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/for-deployment-260789ef-e52d-498b-bcb3-deaed7b6ee47/lock_files' to option 'lock_path'.
2020-05-28 21:04:07.975 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' is configured. lock_path = /root/.rally/verification/verifier-1f95ccd7-57de-4d0a-9af6-71ac3735569e/for-deployment-260789ef-e52d-498b-bcb3-deaed7b6ee47/lock_files
2020-05-28 21:04:07.975 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'img_dir' is already configured in Tempest config file. img_dir = /home/opnfv/functest/images
2020-05-28 21:04:07.975 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'img_file' is already configured in Tempest config file. img_file = cirros-0.4.0-x86_64-disk.img
2020-05-28 21:04:07.975 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref' is already configured in Tempest config file. image_ref = 453a8489-4e36-4004-8246-de480d9803af
2020-05-28 21:04:07.976 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref_alt' is already configured in Tempest config file. image_ref_alt = e42c8a7e-bbff-4bb7-8a76-0c9ca638da00
2020-05-28 21:04:07.977 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref' is already configured in Tempest config file. flavor_ref = 20dd98aa-0203-4dc7-9fd3-8f9adba05677
2020-05-28 21:04:07.977 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref_alt' is already configured in Tempest config file. flavor_ref_alt = 862844a1-fe91-4eb3-aa0f-d323890e245f
2020-05-28 21:04:08.262 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Shared networks found. 'fixed_network_name' option should be configured.
2020-05-28 21:04:08.262 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'fixed_network_name' is already configured in Tempest config file. fixed_network_name = tempest_heat-net_5d906662-0523-4056-b677-bdd1e5629487
2020-05-28 21:04:08.263 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' from 'orchestration' section is not configured.
2020-05-28 21:04:08.342 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Trying to discover a flavor with the following properties: RAM = 64MB, VCPUs = 1, disk >= 5GiB.
2020-05-28 21:04:08.393 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] The following flavor discovered: 'rally_verify_6221241a_d6hQAfhM'. Using flavor 'rally_verify_6221241a_d6hQAfhM' (ID = e21e8ca4-4e05-40ee-83ab-806b242a3408) for the tests.
2020-05-28 21:04:08.393 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value 'e21e8ca4-4e05-40ee-83ab-806b242a3408' to option 'instance_type'.
2020-05-28 21:04:08.394 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' is configured. instance_type = e21e8ca4-4e05-40ee-83ab-806b242a3408
2020-05-28 21:04:08.395 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context tempest@default setup()  finished in 0.87 sec
2020-05-28 21:04:08.396 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context testr@default setup()  finished in 0.46 msec
2020-05-28 21:04:08.396 34 RALLYDEBUG rally.plugins.verification.testr [-] Test(s) started by the command: 'stestr run --subunit --serial --load-list /tmp/8784a4fb-266d-4ad0-9ce8-d0884b1a3455'.
2020-05-28 21:04:13.557 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_stack_list.test_request ... success [0.089s]
2020-05-28 21:04:14.009 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_create_empty_stack.test_request ... success [0.451s]
2020-05-28 21:04:16.241 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_empty_create_complete.test_request ... success [2.232s]
2020-05-28 21:04:16.273 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_show_empty_stack.test_request ... success [0.032s]
2020-05-28 21:04:16.327 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_delete_empty_stack.test_request ... success [0.053s]
2020-05-28 21:04:16.722 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_create_stack.test_request ... success [0.394s]
2020-05-28 21:04:18.963 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_create_complete.test_request ... success [2.240s]
2020-05-28 21:04:19.011 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_show_stack.test_request ... success [0.048s]
2020-05-28 21:04:19.082 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_update_stack.test_request ... success [0.071s]
2020-05-28 21:04:23.516 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_update_complete.test_request ... success [4.434s]
2020-05-28 21:04:23.579 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_patch_update_stack.test_request ... success [0.063s]
2020-05-28 21:04:27.936 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_patch_update_complete.test_request ... success [4.356s]
2020-05-28 21:04:28.032 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_list_stack_outputs.test_request ... success [0.096s]
2020-05-28 21:04:28.143 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_get_stack_output.test_request ... success [0.110s]
2020-05-28 21:04:28.229 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_delete_stack.test_request ... success [0.086s]
2020-05-28 21:04:28.559 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_list_template_versions.test_request ... success [0.237s]
2020-05-28 21:04:28.652 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_list_template_functions.test_request ... success [0.092s]
2020-05-28 21:04:28.678 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_template_validate.test_request ... success [0.027s]
2020-05-28 21:04:29.109 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_list_resource_types.test_request ... success [0.342s]
2020-05-28 21:04:29.271 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_show_resource_type.test_request ... success [0.162s]
2020-05-28 21:04:29.429 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_resource_type_template.test_request ... success [0.157s]
2020-05-28 21:04:29.989 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_environment_with_parameter.test_request ... success [0.511s]
2020-05-28 21:04:32.223 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_poll_for_envstack_create_complete.test_request ... success [2.234s]
2020-05-28 21:04:32.329 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_get_stack_output.test_request ... success [0.105s]
2020-05-28 21:04:32.426 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_delete_envstack.test_request ... success [0.098s]
2020-05-28 21:04:32.959 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_create_stack_with_resources.test_request ... success [0.446s]
2020-05-28 21:04:35.191 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_poll_for_rsrcstack_create_complete.test_request ... success [2.231s]
2020-05-28 21:04:35.368 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_list_resources.test_request ... success [0.176s]
2020-05-28 21:04:35.478 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_list_filtered_resources.test_request ... success [0.110s]
2020-05-28 21:04:35.587 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_show_resource.test_request ... success [0.108s]
2020-05-28 21:04:35.659 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_mark_resource_unhealthy.test_request ... success [0.072s]
2020-05-28 21:04:35.833 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_show_unhealthy_resource.test_request ... success [0.173s]
2020-05-28 21:04:35.881 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_signal_resource.test_request ... success [0.047s]
2020-05-28 21:04:35.971 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_delete_stack_with_resources.test_request ... success [0.091s]
2020-05-28 21:04:36.241 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_create_software_config.test_request ... success [0.169s]
2020-05-28 21:04:36.414 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_config.test_request ... success [0.172s]
2020-05-28 21:04:36.523 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_create_software_deployment.test_request ... success [0.110s]
2020-05-28 21:04:36.696 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_deployment.test_request ... success [0.172s]
2020-05-28 21:04:36.862 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_deployment_metadata.test_request ... success [0.167s]
2020-05-28 21:04:36.964 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_update_deployment.test_request ... success [0.102s]
2020-05-28 21:04:37.127 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_list_software_configs.test_request ... success [0.163s]
2020-05-28 21:04:37.292 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_list_software_deployments.test_request ... success [0.165s]
2020-05-28 21:04:37.336 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_delete_deployment.test_request ... success [0.043s]
2020-05-28 21:04:37.373 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_delete_config.test_request ... success [0.038s]
2020-05-28 21:04:50.734 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_port.UpdatePortTest.test_update_remove_ip ... success [13.359s]
2020-05-28 21:05:04.032 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_port.UpdatePortTest.test_update_with_mac_address ... success [13.298s]
2020-05-28 21:05:18.244 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_allocation_pools ... success [14.211s]
2020-05-28 21:05:31.784 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_allocation_pools_to_empty ... success [13.540s]
2020-05-28 21:05:45.349 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_gateway_ip ... success [13.564s]
2020-05-28 21:05:58.834 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_gateway_ip_to_empty ... success [13.484s]
2020-05-28 21:06:12.994 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_to_no_allocation_pools ... success [14.160s]
2020-05-28 21:06:26.494 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_to_no_gateway_ip ... success [13.500s]
2020-05-28 21:06:48.845 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_add_a_second_sub_port ... success [22.350s]
2020-05-28 21:07:10.594 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_add_first_sub_port ... success [21.749s]
2020-05-28 21:07:32.301 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_remove_last_sub_port_from_trunk ... success [21.706s]
2020-05-28 21:07:53.936 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_remove_sub_port_from_trunk ... success [21.635s]
2020-05-28 21:08:15.605 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_update_existing_sub_port_on_trunk ... success [21.669s]
2020-05-28 21:08:41.383 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_update_trunk_name_and_description ... success [25.777s]
2020-05-28 21:08:59.315 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_encrypted_parameter.EncryptedParametersTest.test_db_encryption ... success [17.932s]
2020-05-28 21:09:12.877 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_encryption_vol_type.EncryptionVolTypeTest.test_create_update ... success [13.561s]
2020-05-28 21:09:21.896 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_create_with_external_ref ... success [9.018s]
2020-05-28 21:09:35.083 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_update_stack_contain_external_ref ... success [13.186s]
2020-05-28 21:09:48.227 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_update_with_external_ref ... success [13.144s]
2020-05-28 21:10:01.704 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create ... success [13.475s]
2020-05-28 21:10:15.315 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create_nested ... success [13.611s]
2020-05-28 21:10:33.241 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create_wildcard ... success [17.926s]
2020-05-28 21:10:46.695 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_in_place ... success [13.453s]
2020-05-28 21:11:04.423 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_nochange ... success [17.727s]
2020-05-28 21:11:21.984 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_replace ... success [17.562s]
2020-05-28 21:11:22.212 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_lbaasv2.LoadBalancerv2Test.test_add_delete_poolmember ... skip [0.226s]: b'LBaasv2 extension not available, skipping'
2020-05-28 21:11:22.332 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_lbaasv2.LoadBalancerv2Test.test_create_update_loadbalancer ... skip [0.119s]: b'LBaasv2 extension not available, skipping'
2020-05-28 21:11:43.560 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.CreateServerTest.test_create_server_with_port ... success [21.228s]
2020-05-28 21:12:10.339 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.CreateServerTest.test_create_server_with_subnet_fixed_ip_sec_group ... success [26.778s]
2020-05-28 21:12:44.612 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.CreateServerTest.test_create_update_server_with_subnet ... success [34.272s]
2020-05-28 21:13:16.700 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_network ... success [32.088s]
2020-05-28 21:13:43.544 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_same_fixed_ip ... success [26.843s]
2020-05-28 21:14:14.473 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_subnet ... success [30.929s]
2020-05-28 21:14:55.198 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_multi_networks_swaps ... success [40.724s]
2020-05-28 21:15:22.118 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_network_port ... success [26.920s]
2020-05-28 21:15:50.169 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_network_subnet ... success [28.050s]
2020-05-28 21:16:21.055 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_subnet_network ... success [30.885s]
2020-05-28 21:16:46.266 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_os_wait_condition.OSWaitCondition.test_create_stack_with_multi_signal_waitcondition ... success [25.210s]
2020-05-28 21:16:46.524 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_basic_fail ... success [0.257s]
2020-05-28 21:16:46.690 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_basic_pass ... success [0.165s]
2020-05-28 21:16:46.853 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_nested_pass ... success [0.163s]
2020-05-28 21:16:47.030 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_res_group_with_nested_template ... success [0.177s]
2020-05-28 21:16:55.972 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_remote_stack_alone ... success [8.940s]
2020-05-28 21:17:05.391 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_create ... success [9.419s]
2020-05-28 21:17:05.675 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_create_bad_region ... success [0.282s]
2020-05-28 21:17:05.676 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_create_with_cloud_credential ... skip [0.000s]: b'multi_cloud - Feature not enabled.'
2020-05-28 21:17:05.857 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_resource_validation_fail ... success [0.182s]
2020-05-28 21:17:23.534 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_suspend_resume ... success [17.676s]
2020-05-28 21:17:37.295 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_update ... success [13.760s]
2020-05-28 21:17:46.371 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_resources_list.ResourcesList.test_filtering_with_depend ... success [9.076s]
2020-05-28 21:17:55.359 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_resources_list.ResourcesList.test_required_by ... success [8.987s]
2020-05-28 21:19:05.109 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_software_config.ParallelDeploymentsTest.test_deployments_metadata ... success [69.749s]
2020-05-28 21:20:32.075 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_software_config.ParallelDeploymentsTest.test_deployments_timeout_failed ... success [86.965s]
2020-05-28 21:20:41.574 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_events.StackEventsTest.test_event ... success [9.499s]
2020-05-28 21:20:54.863 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_output_error_nested ... success [13.288s]
2020-05-28 21:21:03.901 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_outputs ... success [9.037s]
2020-05-28 21:21:17.108 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_outputs_update_new_resource ... success [13.207s]
2020-05-28 21:21:26.102 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_tags.StackTagTest.test_hidden_stack ... success [8.993s]
2020-05-28 21:21:43.446 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_tags.StackTagTest.test_stack_tag ... success [17.343s]
2020-05-28 21:21:43.685 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_basic ... success [0.238s]
2020-05-28 21:21:43.825 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_basic_required_param ... success [0.140s]
2020-05-28 21:21:43.955 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_fail_version ... success [0.129s]
2020-05-28 21:21:44.097 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_off ... success [0.141s]
2020-05-28 21:21:44.234 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_on ... success [0.137s]
2020-05-28 21:21:44.372 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_on_multiple ... success [0.138s]
2020-05-28 21:21:44.510 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_override_default ... success [0.137s]
2020-05-28 21:21:44.637 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_override_none ... success [0.127s]
2020-05-28 21:21:44.777 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_parameter_groups ... success [0.139s]
2020-05-28 21:21:53.615 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_get_stack_template ... success [8.837s]
2020-05-28 21:21:54.302 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_resource_types ... success [0.687s]
2020-05-28 21:21:54.441 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_show_resource_template ... success [0.138s]
2020-05-28 21:22:03.392 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_create_stack ... success [8.950s]
2020-05-28 21:22:03.632 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_stack_preview ... success [0.239s]
2020-05-28 21:22:03.773 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_template_validate_basic ... success [0.140s]
2020-05-28 21:22:03.906 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_template_validate_override_default ... success [0.133s]
2020-05-28 21:22:03.915 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_aodh_alarm.AodhAlarmTest.test_alarm ... skip [0.007s]: b'Test disabled in conf, skipping'
2020-05-28 21:22:04.632 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_autoscaling_lb.AutoscalingLoadBalancerTest.test_autoscaling_loadbalancer_neutron ... skip [0.715s]: b'LBaas v1 extension not available, skipping'
2020-05-28 21:22:05.677 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_autoscaling_lbv2.AutoscalingLoadBalancerv2Test.test_autoscaling_loadbalancer_neutron ... skip [1.044s]: b'LBaasv2 extension not available, skipping'
2020-05-28 21:22:57.101 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_base_resources.BasicResourcesTest.test_base_resources_integration ... success [51.421s]
2020-05-28 21:22:57.108 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_octavia_lbaas.LoadBalancerTest.test_add_delete_poolmember ... skip [0.006s]: b'Test disabled in conf, skipping'
2020-05-28 21:22:57.112 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_octavia_lbaas.LoadBalancerTest.test_create_update_loadbalancer ... skip [0.004s]: b'Test disabled in conf, skipping'
2020-05-28 21:23:06.805 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_remote_deeply_nested.RemoteDeeplyNestedStackTest.test_remote_nested ... success [9.692s]
2020-05-28 21:23:06.813 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_cfn_init.CfnInitIntegrationTest.test_server_cfn_init ... skip [0.007s]: b'Test disabled in conf, skipping'
2020-05-28 21:23:44.140 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_signal.ServerSignalIntegrationTest.test_server_signal_userdata_format_raw ... success [37.321s]
2020-05-28 21:24:46.195 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_signal.ServerSignalIntegrationTest.test_server_signal_userdata_format_software_config ... success [62.053s]
2020-05-28 21:24:46.199 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_software_config.SoftwareConfigIntegrationTest.test_server_software_config ... skip [0.007s]: b'Test disabled in conf, skipping'
2020-05-28 21:24:46.202 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_volumes.VolumeBackupRestoreIntegrationTest.test_cinder_volume_create_backup_restore ... skip [0.004s]: b'Test disabled in conf, skipping'
2020-05-28 21:24:46.490 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context testr@default cleanup() started
2020-05-28 21:24:46.491 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context testr@default cleanup() finished in 0.75 msec
2020-05-28 21:24:46.491 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context tempest@default cleanup() started
2020-05-28 21:24:46.689 34 INFO rally.task.context [-] Verification 1f95ccd7-57de-4d0a-9af6-71ac3735569e | Context tempest@default cleanup() finished in 0.20 sec
2020-05-28 21:24:46.726 34 INFO rally.api [-] Verification (UUID=c43b59d2-e2dc-4e16-a4a2-fc4238562cbe) has been successfully finished for deployment 'opnfv-rally' (UUID=260789ef-e52d-498b-bcb3-deaed7b6ee47)!
2020-05-28 21:24:48.490 42 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:24:48.491 42 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:24:48.491 42 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:24:50.093 44 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:24:50.094 44 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:24:50.094 44 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:24:52.165 44 INFO rally.api [-] Building 'html' report for the following verification(s): 'c43b59d2-e2dc-4e16-a4a2-fc4238562cbe'
2020-05-28 21:24:52.187 44 INFO rally.api [-] The report has been successfully built.
2020-05-28 21:24:53.710 46 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-05-28 21:24:53.710 46 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-05-28 21:24:53.710 46 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-05-28 21:24:55.749 46 INFO rally.api [-] Building 'junit-xml' report for the following verification(s): 'c43b59d2-e2dc-4e16-a4a2-fc4238562cbe'
2020-05-28 21:24:55.757 46 INFO rally.api [-] The report has been successfully built.
