2020-04-20 20:16:29.931 7 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:29.931 7 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:29.931 7 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:31.715 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-04-20 20:16:31.715 7 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/cliutils.py", line 657, in run
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "<decorator-gen-16>", line 2, in destroy
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/envutils.py", line 135, in default_from_global
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "<decorator-gen-15>", line 2, in destroy
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/commands/deployment.py", line 154, in destroy
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     api.deployment.destroy(deployment=deployment)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 115, in destroy
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     deploy = objects.Deployment.get(deployment)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/objects/deploy.py", line 124, in get
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     return Deployment(env_mgr.EnvManager.get(deploy))
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/env/env_mgr.py", line 212, in get
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     return cls(db.env_get(uuid_or_name))
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 133, in wrapper
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 518, in env_get
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2020-04-20 20:16:31.715 7 ERROR rally.cli.cliutils 
2020-04-20 20:16:33.080 9 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:33.080 9 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:33.080 9 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:36.201 11 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:36.201 11 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:36.201 11 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:39.223 14 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:39.223 14 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:39.224 14 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:40.345 17 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:40.345 17 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:40.345 17 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:41.855 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-04-20 20:16:41.855 17 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/cliutils.py", line 657, in run
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "<decorator-gen-67>", line 2, in delete_verifier
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/commands/verify.py", line 234, in delete_verifier
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     api.verifier.delete(verifier_id=verifier_id,
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 690, in delete
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     verifier = self._get(verifier_id)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 664, in _get
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     return objects.Verifier.get(verifier_id)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/objects/verifier.py", line 69, in get
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     return cls(db.verifier_get(verifier_id))
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 133, in wrapper
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 667, in verifier_get
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     return _verifier_get(session, verifier_id)
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 676, in _verifier_get
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2020-04-20 20:16:41.855 17 ERROR rally.cli.cliutils 
2020-04-20 20:16:43.121 19 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:43.121 19 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:43.121 19 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:44.686 19 INFO rally.api [-] Creating verifier 'opnfv-tempest'.
2020-04-20 20:16:44.746 19 RALLYDEBUG rally.verification.manager [-] Cloning verifier repo from /src/tempest into /root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/repo.
2020-04-20 20:16:44.952 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'Cloning into '/root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/repo'...
done.
'
2020-04-20 20:16:44.963 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'heads/master
'
2020-04-20 20:16:44.982 19 RALLYDEBUG rally.verification.manager [-] Checking system-wide packages for verifier.
2020-04-20 20:16:45.022 19 RALLYDEBUG rally.plugins.verification.testr [-] Initializing testr.
2020-04-20 20:16:45.590 19 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=cde7da44-b5fa-401a-8557-24d4b20e755e) has been successfully created!
2020-04-20 20:16:46.846 26 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:46.846 26 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:46.846 26 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:54.964 29 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:16:54.964 29 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:16:54.965 29 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:16:56.575 29 INFO rally.api [-] Configuring verifier 'opnfv-tempest' (UUID=cde7da44-b5fa-401a-8557-24d4b20e755e) for deployment 'opnfv-rally' (UUID=cd269d3a-613d-40cc-8110-d22ebb171724).
2020-04-20 20:16:56.921 29 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=cde7da44-b5fa-401a-8557-24d4b20e755e) has been successfully configured for deployment 'opnfv-rally' (UUID=cd269d3a-613d-40cc-8110-d22ebb171724)!
2020-04-20 20:17:04.476 34 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:17:04.477 34 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:17:04.477 34 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:17:06.255 34 INFO rally.api [-] Starting verification (UUID=c51fe546-a8a7-47e0-958c-e53bcfa3e16a) for deployment 'opnfv-rally' (UUID=cd269d3a-613d-40cc-8110-d22ebb171724) by verifier 'opnfv-tempest' (UUID=cde7da44-b5fa-401a-8557-24d4b20e755e).
2020-04-20 20:17:06.823 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' from 'DEFAULT' section is not configured.
2020-04-20 20:17:06.824 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/for-deployment-cd269d3a-613d-40cc-8110-d22ebb171724/tempest.log' to option 'log_file'.
2020-04-20 20:17:06.824 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' is configured. log_file = /root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/for-deployment-cd269d3a-613d-40cc-8110-d22ebb171724/tempest.log
2020-04-20 20:17:06.824 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' from 'oslo_concurrency' section is not configured.
2020-04-20 20:17:06.825 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/for-deployment-cd269d3a-613d-40cc-8110-d22ebb171724/lock_files' to option 'lock_path'.
2020-04-20 20:17:06.825 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' is configured. lock_path = /root/.rally/verification/verifier-cde7da44-b5fa-401a-8557-24d4b20e755e/for-deployment-cd269d3a-613d-40cc-8110-d22ebb171724/lock_files
2020-04-20 20:17:06.825 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'img_dir' is already configured in Tempest config file. img_dir = /home/opnfv/functest/images
2020-04-20 20:17:06.825 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-04-20 20:17:06.826 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref' is already configured in Tempest config file. image_ref = 5a1a31cd-563d-446e-812c-debf654e0b19
2020-04-20 20:17:06.826 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref_alt' is already configured in Tempest config file. image_ref_alt = df224e38-c21a-4beb-99a4-32fb61a116b8
2020-04-20 20:17:06.827 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref' is already configured in Tempest config file. flavor_ref = 8fcfc1fb-edd9-410f-b7ec-9fd916700e1b
2020-04-20 20:17:06.827 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref_alt' is already configured in Tempest config file. flavor_ref_alt = d1902d59-8acc-493b-9f3b-b59170ffb62f
2020-04-20 20:17:07.044 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Shared networks found. 'fixed_network_name' option should be configured.
2020-04-20 20:17:07.045 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'fixed_network_name' is already configured in Tempest config file. fixed_network_name = tempest_heat-net_16b47a7d-1a20-4dd5-9a2a-dbffee9de0a1
2020-04-20 20:17:07.045 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' from 'orchestration' section is not configured.
2020-04-20 20:17:07.118 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Trying to discover a flavor with the following properties: RAM = 64MB, VCPUs = 1, disk >= 5GiB.
2020-04-20 20:17:07.165 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] The following flavor discovered: 'rally_verify_0d853cfd_m5sf9mo5'. Using flavor 'rally_verify_0d853cfd_m5sf9mo5' (ID = 53320f63-8485-4b53-906e-312ede79a862) for the tests.
2020-04-20 20:17:07.165 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '53320f63-8485-4b53-906e-312ede79a862' to option 'instance_type'.
2020-04-20 20:17:07.165 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' is configured. instance_type = 53320f63-8485-4b53-906e-312ede79a862
2020-04-20 20:17:07.167 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context tempest@default setup()  finished in 0.71 sec
2020-04-20 20:17:07.168 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context testr@default setup()  finished in 0.46 msec
2020-04-20 20:17:07.168 34 RALLYDEBUG rally.plugins.verification.testr [-] Test(s) started by the command: 'stestr run --subunit --serial --load-list /tmp/dabe6195-10f1-4f71-8bd4-4fcfe76ef9e9'.
2020-04-20 20:17:11.616 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_stack_list.test_request ... success [0.088s]
2020-04-20 20:17:12.042 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_create_empty_stack.test_request ... success [0.426s]
2020-04-20 20:17:14.201 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_empty_create_complete.test_request ... success [2.158s]
2020-04-20 20:17:14.235 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_show_empty_stack.test_request ... success [0.034s]
2020-04-20 20:17:14.293 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_delete_empty_stack.test_request ... success [0.058s]
2020-04-20 20:17:14.695 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_create_stack.test_request ... success [0.402s]
2020-04-20 20:17:16.871 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_create_complete.test_request ... success [2.176s]
2020-04-20 20:17:16.912 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_show_stack.test_request ... success [0.041s]
2020-04-20 20:17:17.000 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_update_stack.test_request ... success [0.088s]
2020-04-20 20:17:21.286 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_update_complete.test_request ... success [4.285s]
2020-04-20 20:17:21.353 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_patch_update_stack.test_request ... success [0.067s]
2020-04-20 20:17:25.628 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_poll_for_stack_patch_update_complete.test_request ... success [4.274s]
2020-04-20 20:17:25.699 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_list_stack_outputs.test_request ... success [0.072s]
2020-04-20 20:17:25.776 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_get_stack_output.test_request ... success [0.076s]
2020-04-20 20:17:25.858 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.stacks_delete_stack.test_request ... success [0.082s]
2020-04-20 20:17:26.521 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_create_stack_with_resources.test_request ... success [0.565s]
2020-04-20 20:17:28.706 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_poll_for_rsrcstack_create_complete.test_request ... success [2.185s]
2020-04-20 20:17:28.850 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_list_resources.test_request ... success [0.144s]
2020-04-20 20:17:29.143 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_list_filtered_resources.test_request ... success [0.292s]
2020-04-20 20:17:29.228 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_show_resource.test_request ... success [0.086s]
2020-04-20 20:17:29.298 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_mark_resource_unhealthy.test_request ... success [0.068s]
2020-04-20 20:17:29.421 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_show_unhealthy_resource.test_request ... success [0.123s]
2020-04-20 20:17:29.462 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_signal_resource.test_request ... success [0.041s]
2020-04-20 20:17:29.555 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resources_delete_stack_with_resources.test_request ... success [0.092s]
2020-04-20 20:17:29.884 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_list_template_versions.test_request ... success [0.233s]
2020-04-20 20:17:29.949 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_list_template_functions.test_request ... success [0.065s]
2020-04-20 20:17:29.972 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.templates_template_validate.test_request ... success [0.023s]
2020-04-20 20:17:30.235 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_create_software_config.test_request ... success [0.161s]
2020-04-20 20:17:30.359 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_config.test_request ... success [0.124s]
2020-04-20 20:17:30.438 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_create_software_deployment.test_request ... success [0.078s]
2020-04-20 20:17:30.554 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_deployment.test_request ... success [0.116s]
2020-04-20 20:17:30.683 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_show_deployment_metadata.test_request ... success [0.129s]
2020-04-20 20:17:30.775 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_update_deployment.test_request ... success [0.091s]
2020-04-20 20:17:30.891 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_list_software_configs.test_request ... success [0.115s]
2020-04-20 20:17:31.017 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_list_software_deployments.test_request ... success [0.126s]
2020-04-20 20:17:31.065 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_delete_deployment.test_request ... success [0.048s]
2020-04-20 20:17:31.109 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.softwareconfig_delete_config.test_request ... success [0.044s]
2020-04-20 20:17:31.493 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_list_resource_types.test_request ... success [0.323s]
2020-04-20 20:17:31.619 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_show_resource_type.test_request ... success [0.126s]
2020-04-20 20:17:31.731 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.resourcetypes_resource_type_template.test_request ... success [0.112s]
2020-04-20 20:17:32.286 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_environment_with_parameter.test_request ... success [0.509s]
2020-04-20 20:17:34.476 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_poll_for_envstack_create_complete.test_request ... success [2.190s]
2020-04-20 20:17:34.561 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_get_stack_output.test_request ... success [0.084s]
2020-04-20 20:17:34.643 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.api.test_heat_api.environments_delete_envstack.test_request ... success [0.081s]
2020-04-20 20:17:52.062 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_port.UpdatePortTest.test_update_remove_ip ... success [17.418s]
2020-04-20 20:18:05.612 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_port.UpdatePortTest.test_update_with_mac_address ... success [13.550s]
2020-04-20 20:18:19.214 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_allocation_pools ... success [13.601s]
2020-04-20 20:18:32.797 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_allocation_pools_to_empty ... success [13.582s]
2020-04-20 20:18:46.444 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_gateway_ip ... success [13.645s]
2020-04-20 20:18:59.979 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_gateway_ip_to_empty ... success [13.535s]
2020-04-20 20:19:13.524 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_to_no_allocation_pools ... success [13.544s]
2020-04-20 20:19:31.207 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_subnet.UpdateSubnetTest.test_update_to_no_gateway_ip ... success [17.682s]
2020-04-20 20:19:53.865 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_add_a_second_sub_port ... success [22.657s]
2020-04-20 20:20:19.648 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_add_first_sub_port ... success [25.783s]
2020-04-20 20:20:41.453 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.803s]
2020-04-20 20:21:03.300 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_remove_sub_port_from_trunk ... success [21.845s]
2020-04-20 20:21:24.885 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.584s]
2020-04-20 20:21:46.469 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_create_update_neutron_trunk.UpdateTrunkTest.test_update_trunk_name_and_description ... success [21.584s]
2020-04-20 20:22:03.892 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_encrypted_parameter.EncryptedParametersTest.test_db_encryption ... success [17.422s]
2020-04-20 20:22:17.702 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_encryption_vol_type.EncryptionVolTypeTest.test_create_update ... success [13.809s]
2020-04-20 20:22:26.821 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_create_with_external_ref ... success [9.118s]
2020-04-20 20:22:40.099 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_update_stack_contain_external_ref ... success [13.277s]
2020-04-20 20:22:53.289 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_external_ref.ExternalReferencesTest.test_update_with_external_ref ... success [13.189s]
2020-04-20 20:23:02.807 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create ... success [9.517s]
2020-04-20 20:23:16.399 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create_nested ... success [13.591s]
2020-04-20 20:23:34.391 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_create_wildcard ... success [17.991s]
2020-04-20 20:23:47.969 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_in_place ... success [13.577s]
2020-04-20 20:24:05.645 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_nochange ... success [17.676s]
2020-04-20 20:24:23.322 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_hooks.HooksTest.test_hook_pre_update_replace ... success [17.676s]
2020-04-20 20:24:23.629 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_lbaasv2.LoadBalancerv2Test.test_add_delete_poolmember ... skip [0.306s]: b'LBaasv2 extension not available, skipping'
2020-04-20 20:24:23.794 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_lbaasv2.LoadBalancerv2Test.test_create_update_loadbalancer ... skip [0.163s]: b'LBaasv2 extension not available, skipping'
2020-04-20 20:24:49.132 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.CreateServerTest.test_create_server_with_port ... success [25.338s]
2020-04-20 20:25:15.628 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.496s]
2020-04-20 20:25:54.353 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.CreateServerTest.test_create_update_server_with_subnet ... success [38.724s]
2020-04-20 20:26:25.522 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_network ... success [31.168s]
2020-04-20 20:26:57.074 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_same_fixed_ip ... success [31.552s]
2020-04-20 20:27:28.219 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_add_subnet ... success [31.144s]
2020-04-20 20:28:04.572 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_multi_networks_swaps ... success [36.353s]
2020-04-20 20:28:35.797 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_network_port ... success [31.224s]
2020-04-20 20:29:03.480 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_network_subnet ... success [27.683s]
2020-04-20 20:29:35.482 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_nova_server_networks.UpdateServerNetworksTest.test_create_update_server_swap_subnet_network ... success [32.001s]
2020-04-20 20:29:56.849 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_os_wait_condition.OSWaitCondition.test_create_stack_with_multi_signal_waitcondition ... success [21.366s]
2020-04-20 20:29:57.118 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_basic_fail ... success [0.268s]
2020-04-20 20:29:57.284 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_basic_pass ... success [0.166s]
2020-04-20 20:29:57.529 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_nested_pass ... success [0.244s]
2020-04-20 20:29:57.700 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_preview.StackPreviewTest.test_res_group_with_nested_template ... success [0.170s]
2020-04-20 20:30:06.656 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_remote_stack_alone ... success [8.955s]
2020-04-20 20:30:16.121 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_create ... success [9.465s]
2020-04-20 20:30:16.429 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_create_bad_region ... success [0.306s]
2020-04-20 20:30:16.430 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-04-20 20:30:16.646 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_resource_validation_fail ... success [0.217s]
2020-04-20 20:30:34.466 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_suspend_resume ... success [17.819s]
2020-04-20 20:30:48.329 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_remote_stack.RemoteStackTest.test_stack_update ... success [13.862s]
2020-04-20 20:30:57.377 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_resources_list.ResourcesList.test_filtering_with_depend ... success [9.047s]
2020-04-20 20:31:06.572 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_resources_list.ResourcesList.test_required_by ... success [9.194s]
2020-04-20 20:32:12.500 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_software_config.ParallelDeploymentsTest.test_deployments_metadata ... success [65.926s]
2020-04-20 20:33:39.504 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_software_config.ParallelDeploymentsTest.test_deployments_timeout_failed ... success [87.004s]
2020-04-20 20:33:49.040 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_events.StackEventsTest.test_event ... success [9.534s]
2020-04-20 20:34:02.274 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_output_error_nested ... success [13.233s]
2020-04-20 20:34:11.364 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_outputs ... success [9.090s]
2020-04-20 20:34:24.495 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_outputs.StackOutputsTest.test_outputs_update_new_resource ... success [13.130s]
2020-04-20 20:34:33.480 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_tags.StackTagTest.test_hidden_stack ... success [8.985s]
2020-04-20 20:34:50.953 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_stack_tags.StackTagTest.test_stack_tag ... success [17.472s]
2020-04-20 20:34:51.225 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_basic ... success [0.272s]
2020-04-20 20:34:51.382 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_basic_required_param ... success [0.157s]
2020-04-20 20:34:51.594 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_fail_version ... success [0.211s]
2020-04-20 20:34:51.755 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_off ... success [0.161s]
2020-04-20 20:34:51.925 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_on ... success [0.169s]
2020-04-20 20:34:52.094 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_nested_on_multiple ... success [0.169s]
2020-04-20 20:34:52.253 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_override_default ... success [0.158s]
2020-04-20 20:34:52.419 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_override_none ... success [0.165s]
2020-04-20 20:34:52.576 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_template_validate.StackTemplateValidateTest.test_template_validate_parameter_groups ... success [0.157s]
2020-04-20 20:35:01.454 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_get_stack_template ... success [8.877s]
2020-04-20 20:35:01.901 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_resource_types ... success [0.446s]
2020-04-20 20:35:02.069 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_templates.TemplateAPITest.test_show_resource_template ... success [0.167s]
2020-04-20 20:35:11.086 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_create_stack ... success [9.017s]
2020-04-20 20:35:11.366 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_stack_preview ... success [0.279s]
2020-04-20 20:35:11.537 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_template_validate_basic ... success [0.171s]
2020-04-20 20:35:11.780 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.functional.test_unicode_template.StackUnicodeTemplateTest.test_template_validate_override_default ... success [0.242s]
2020-04-20 20:35:11.787 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_aodh_alarm.AodhAlarmTest.test_alarm ... skip [0.006s]: b'Test disabled in conf, skipping'
2020-04-20 20:35:13.370 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_autoscaling_lb.AutoscalingLoadBalancerTest.test_autoscaling_loadbalancer_neutron ... skip [1.581s]: b'LBaas v1 extension not available, skipping'
2020-04-20 20:35:13.934 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_autoscaling_lbv2.AutoscalingLoadBalancerv2Test.test_autoscaling_loadbalancer_neutron ... skip [0.564s]: b'LBaasv2 extension not available, skipping'
2020-04-20 20:36:00.416 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_base_resources.BasicResourcesTest.test_base_resources_integration ... success [46.483s]
2020-04-20 20:36:14.139 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_remote_deeply_nested.RemoteDeeplyNestedStackTest.test_remote_nested ... success [13.722s]
2020-04-20 20:37:08.435 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_cfn_init.CfnInitIntegrationTest.test_server_cfn_init ... success [54.289s]
2020-04-20 20:37:36.481 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_signal.ServerSignalIntegrationTest.test_server_signal_userdata_format_raw ... success [28.046s]
2020-04-20 20:38:25.546 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_signal.ServerSignalIntegrationTest.test_server_signal_userdata_format_software_config ... success [49.057s]
2020-04-20 20:38:25.547 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_server_software_config.SoftwareConfigIntegrationTest.test_server_software_config ... skip [0.008s]: b'Test disabled in conf, skipping'
2020-04-20 20:38:25.551 34 INFO opnfv-tempest [-] {0} heat_tempest_plugin.tests.scenario.test_volumes.VolumeBackupRestoreIntegrationTest.test_cinder_volume_create_backup_restore ... skip [0.005s]: b'Test disabled in conf, skipping'
2020-04-20 20:38:25.943 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context testr@default cleanup() started
2020-04-20 20:38:25.944 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context testr@default cleanup() finished in 0.94 msec
2020-04-20 20:38:25.944 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context tempest@default cleanup() started
2020-04-20 20:38:26.167 34 INFO rally.task.context [-] Verification cde7da44-b5fa-401a-8557-24d4b20e755e | Context tempest@default cleanup() finished in 0.22 sec
2020-04-20 20:38:26.190 34 INFO rally.api [-] Verification (UUID=c51fe546-a8a7-47e0-958c-e53bcfa3e16a) has been successfully finished for deployment 'opnfv-rally' (UUID=cd269d3a-613d-40cc-8110-d22ebb171724)!
2020-04-20 20:38:27.881 47 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:38:27.881 47 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:38:27.881 47 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:38:29.270 49 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:38:29.270 49 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:38:29.270 49 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:38:31.056 49 INFO rally.api [-] Building 'html' report for the following verification(s): 'c51fe546-a8a7-47e0-958c-e53bcfa3e16a'
2020-04-20 20:38:31.072 49 INFO rally.api [-] The report has been successfully built.
2020-04-20 20:38:32.270 51 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-20 20:38:32.271 51 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-20 20:38:32.271 51 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-20 20:38:33.700 51 INFO rally.api [-] Building 'junit-xml' report for the following verification(s): 'c51fe546-a8a7-47e0-958c-e53bcfa3e16a'
2020-04-20 20:38:33.705 51 INFO rally.api [-] The report has been successfully built.
