2021-02-09 09:35:40.246 6 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:40.247 6 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:40.247 6 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils [-] Unexpected exception in CLI: rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils Traceback (most recent call last):
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "</usr/lib/python3.7/site-packages/decorator.py:decorator-gen-16>", line 2, in destroy
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/envutils.py", line 135, in default_from_global
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "</usr/lib/python3.7/site-packages/decorator.py:decorator-gen-15>", line 2, in destroy
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/deployment.py", line 154, in destroy
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     api.deployment.destroy(deployment=deployment)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 115, in destroy
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     deploy = objects.Deployment.get(deployment)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/deploy.py", line 124, in get
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     return Deployment(env_mgr.EnvManager.get(deploy))
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/env/env_mgr.py", line 212, in get
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     return cls(db.env_get(uuid_or_name))
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 519, in env_get
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils     criteria="uuid or name is %s" % uuid_or_name, table="envs")
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2021-02-09 09:35:42.526 6 ERROR rally.cli.cliutils 
2021-02-09 09:35:44.132 8 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:44.132 8 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:44.132 8 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:35:48.296 10 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:48.296 10 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:48.296 10 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:35:53.009 13 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:53.009 13 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:53.010 13 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:35:54.507 15 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:54.508 15 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:54.508 15 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils [-] Unexpected exception in CLI: rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils Traceback (most recent call last):
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "</usr/lib/python3.7/site-packages/decorator.py:decorator-gen-67>", line 2, in delete_verifier
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/verify.py", line 236, in delete_verifier
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     force=force)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 690, in delete
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     verifier = self._get(verifier_id)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 664, in _get
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     return objects.Verifier.get(verifier_id)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/verifier.py", line 69, in get
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     return cls(db.verifier_get(verifier_id))
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 667, in verifier_get
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     return _verifier_get(session, verifier_id)
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 677, in _verifier_get
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils     criteria="name or uuid is %s" % verifier_id, table="verifiers")
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2021-02-09 09:35:56.786 15 ERROR rally.cli.cliutils 
2021-02-09 09:35:58.402 17 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:35:58.402 17 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:35:58.402 17 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:36:00.498 17 INFO rally.api [-] Creating verifier 'opnfv-tempest'.
2021-02-09 09:36:00.576 17 RALLYDEBUG rally.verification.manager [-] Cloning verifier repo from /src/tempest into /root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/repo.
2021-02-09 09:36:00.894 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'Cloning into '/root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/repo'...
done.
Note: checking out '1ff9ce68013680c41243c5f9a9f0f3500bc5be49'.

You are in 'detached HEAD' state. You can look around, make experimental
changes and commit them, and you can discard any commits you make in this
state without impacting any branches by performing another checkout.

If you want to create a new branch to retain commits you create, you may
do so (now or later) by using -b with the checkout command again. Example:

  git checkout -b <new-branch-name>

'
2021-02-09 09:36:00.907 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'tags/22.0.0-1-g1ff9ce680
'
2021-02-09 09:36:00.917 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: '1ff9ce68013680c41243c5f9a9f0f3500bc5be49
'
2021-02-09 09:36:00.941 17 RALLYDEBUG rally.verification.manager [-] Checking system-wide packages for verifier.
2021-02-09 09:36:01.002 17 RALLYDEBUG rally.plugins.verification.testr [-] Initializing testr.
2021-02-09 09:36:01.710 17 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=73030f90-ea65-4762-ae0e-65ad4512b020) has been successfully created!
2021-02-09 09:36:03.466 25 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:36:03.466 25 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:36:03.466 25 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:36:08.021 28 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:36:08.022 28 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:36:08.022 28 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:36:10.172 28 INFO rally.api [-] Configuring verifier 'opnfv-tempest' (UUID=73030f90-ea65-4762-ae0e-65ad4512b020) for deployment 'opnfv-rally' (UUID=310912de-63c1-4df3-bab1-a7c821bd6792).
2021-02-09 09:36:10.607 28 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=73030f90-ea65-4762-ae0e-65ad4512b020) has been successfully configured for deployment 'opnfv-rally' (UUID=310912de-63c1-4df3-bab1-a7c821bd6792)!
2021-02-09 09:36:19.586 32 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:36:19.587 32 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:36:19.587 32 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:36:22.196 32 INFO rally.api [-] Starting verification (UUID=1dd1aa0a-4648-4e50-a99f-5ecebe878917) for deployment 'opnfv-rally' (UUID=310912de-63c1-4df3-bab1-a7c821bd6792) by verifier 'opnfv-tempest' (UUID=73030f90-ea65-4762-ae0e-65ad4512b020).
2021-02-09 09:36:22.895 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' from 'DEFAULT' section is not configured.
2021-02-09 09:36:22.895 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/for-deployment-310912de-63c1-4df3-bab1-a7c821bd6792/tempest.log' to option 'log_file'.
2021-02-09 09:36:22.896 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' is configured. log_file = /root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/for-deployment-310912de-63c1-4df3-bab1-a7c821bd6792/tempest.log
2021-02-09 09:36:22.896 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' from 'oslo_concurrency' section is not configured.
2021-02-09 09:36:22.896 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/for-deployment-310912de-63c1-4df3-bab1-a7c821bd6792/lock_files' to option 'lock_path'.
2021-02-09 09:36:22.896 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' is configured. lock_path = /root/.rally/verification/verifier-73030f90-ea65-4762-ae0e-65ad4512b020/for-deployment-310912de-63c1-4df3-bab1-a7c821bd6792/lock_files
2021-02-09 09:36:22.896 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'img_dir' is already configured in Tempest config file. img_dir = /home/opnfv/functest/images
2021-02-09 09:36:22.896 32 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
2021-02-09 09:36:22.897 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref' is already configured in Tempest config file. image_ref = 8cc4728c-403f-4f1d-8a98-2a0a5dbd478f
2021-02-09 09:36:22.897 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref_alt' is already configured in Tempest config file. image_ref_alt = 27e92a9b-dcf6-42d7-ba7e-55c39beb3d79
2021-02-09 09:36:22.897 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref' is already configured in Tempest config file. flavor_ref = 4037269b-8dbd-4da3-b23c-eea9df8c9f8f
2021-02-09 09:36:22.898 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref_alt' is already configured in Tempest config file. flavor_ref_alt = 44940371-d4bf-4da0-b27d-9c970e2887aa
2021-02-09 09:36:23.119 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Shared networks found. 'fixed_network_name' option should be configured.
2021-02-09 09:36:23.120 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'fixed_network_name' is already configured in Tempest config file. fixed_network_name = tempest_scenario_cntt-net_702e358b-cb8f-4e3a-807a-a9bd87e7e253
2021-02-09 09:36:23.121 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' from 'orchestration' section is not configured.
2021-02-09 09:36:23.196 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Trying to discover a flavor with the following properties: RAM = 64MB, VCPUs = 1, disk >= 5GiB.
2021-02-09 09:36:23.249 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] The following flavor discovered: 'rally_verify_2bbb0147_VslqGQNH'. Using flavor 'rally_verify_2bbb0147_VslqGQNH' (ID = 416dff1d-7962-46a8-b44a-2d63b4ed385a) for the tests.
2021-02-09 09:36:23.249 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '416dff1d-7962-46a8-b44a-2d63b4ed385a' to option 'instance_type'.
2021-02-09 09:36:23.249 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' is configured. instance_type = 416dff1d-7962-46a8-b44a-2d63b4ed385a
2021-02-09 09:36:23.251 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context tempest@default setup()  finished in 0.84 sec
2021-02-09 09:36:23.252 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context testr@default setup()  finished in 0.40 msec
2021-02-09 09:36:23.252 32 RALLYDEBUG rally.plugins.verification.testr [-] Test(s) started by the command: 'stestr run --subunit --serial --load-list /tmp/09ff19bc-338b-4361-9bb4-889b15f039ac'.
2021-02-09 09:37:28.677 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_minimum_basic.TestMinimumBasicScenario.test_minimum_basic_scenario ... success [54.254s]
2021-02-09 09:38:32.411 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_network_basic_ops.TestNetworkBasicOps.test_hotplug_nic ... success [55.681s]
2021-02-09 09:39:46.590 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_network_basic_ops.TestNetworkBasicOps.test_network_basic_ops ... success [74.155s]
2021-02-09 09:39:50.213 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_object_storage_basic_ops.TestObjectStorageBasicOps.test_swift_basic_ops ... success [0.260s]
2021-02-09 09:41:21.180 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_security_groups_basic_ops.TestSecurityGroupsBasicOps.test_cross_tenant_traffic ... success [86.962s]
2021-02-09 09:42:21.198 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_security_groups_basic_ops.TestSecurityGroupsBasicOps.test_in_tenant_traffic ... success [60.004s]
2021-02-09 09:43:02.268 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_server_basic_ops.TestServerBasicOps.test_server_basic_ops ... success [31.904s]
2021-02-09 09:43:59.424 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_server_multinode.TestServerMultinode.test_schedule_to_all_nodes ... success [31.339s]
2021-02-09 09:45:08.474 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_image_defined_boot_from_volume ... success [40.202s]
2021-02-09 09:45:26.700 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context testr@default cleanup() started
2021-02-09 09:45:26.700 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context testr@default cleanup() finished in 0.81 msec
2021-02-09 09:45:26.701 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context tempest@default cleanup() started
2021-02-09 09:45:26.879 32 INFO rally.task.context [-] Verification 73030f90-ea65-4762-ae0e-65ad4512b020 | Context tempest@default cleanup() finished in 0.18 sec
2021-02-09 09:45:26.906 32 INFO rally.api [-] Verification (UUID=1dd1aa0a-4648-4e50-a99f-5ecebe878917) has been successfully finished for deployment 'opnfv-rally' (UUID=310912de-63c1-4df3-bab1-a7c821bd6792)!
2021-02-09 09:45:28.697 145 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:45:28.698 145 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:45:28.698 145 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:45:30.286 146 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:45:30.286 146 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:45:30.286 146 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:45:32.640 146 INFO rally.api [-] Building 'html' report for the following verification(s): '1dd1aa0a-4648-4e50-a99f-5ecebe878917'
2021-02-09 09:45:32.672 146 INFO rally.api [-] The report has been successfully built.
2021-02-09 09:45:34.357 148 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 09:45:34.358 148 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 09:45:34.358 148 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 09:45:36.700 148 INFO rally.api [-] Building 'junit-xml' report for the following verification(s): '1dd1aa0a-4648-4e50-a99f-5ecebe878917'
2021-02-09 09:45:36.702 148 INFO rally.api [-] The report has been successfully built.
