2021-02-09 08:19:46.068 6 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:19:46.068 6 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:19:46.068 6 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:19:48.408 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 08:19:48.408 6 ERROR rally.cli.cliutils Traceback (most recent call last):
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "</usr/lib/python3.7/site-packages/decorator.py:decorator-gen-16>", line 2, in destroy
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/envutils.py", line 135, in default_from_global
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "</usr/lib/python3.7/site-packages/decorator.py:decorator-gen-15>", line 2, in destroy
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/deployment.py", line 154, in destroy
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     api.deployment.destroy(deployment=deployment)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 115, in destroy
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     deploy = objects.Deployment.get(deployment)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/deploy.py", line 124, in get
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     return Deployment(env_mgr.EnvManager.get(deploy))
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/env/env_mgr.py", line 212, in get
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     return cls(db.env_get(uuid_or_name))
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 519, in env_get
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils     criteria="uuid or name is %s" % uuid_or_name, table="envs")
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2021-02-09 08:19:48.408 6 ERROR rally.cli.cliutils 
2021-02-09 08:19:50.150 8 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:19:50.150 8 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:19:50.151 8 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:19:54.499 10 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:19:54.499 10 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:19:54.499 10 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:19:59.231 13 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:19:59.231 13 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:19:59.232 13 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:00.720 15 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:20:00.720 15 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:20:00.721 15 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:02.915 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 08:20:02.915 15 ERROR rally.cli.cliutils Traceback (most recent call last):
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/cliutils.py", line 657, in run
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2021-02-09 08:20:02.915 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 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/plugins/__init__.py", line 59, in ensure_plugins_are_loaded
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/cli/commands/verify.py", line 236, in delete_verifier
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     force=force)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 690, in delete
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     verifier = self._get(verifier_id)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/api.py", line 664, in _get
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     return objects.Verifier.get(verifier_id)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/objects/verifier.py", line 69, in get
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     return cls(db.verifier_get(verifier_id))
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 133, in wrapper
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 667, in verifier_get
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     return _verifier_get(session, verifier_id)
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils   File "/src/rally/rally/common/db/api.py", line 677, in _verifier_get
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils     criteria="name or uuid is %s" % verifier_id, table="verifiers")
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2021-02-09 08:20:02.915 15 ERROR rally.cli.cliutils 
2021-02-09 08:20:04.546 17 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:20:04.546 17 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:20:04.546 17 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:06.931 17 INFO rally.api [-] Creating verifier 'opnfv-tempest'.
2021-02-09 08:20:07.006 17 RALLYDEBUG rally.verification.manager [-] Cloning verifier repo from /src/tempest into /root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/repo.
2021-02-09 08:20:07.300 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'Cloning into '/root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/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 08:20:07.315 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'tags/22.0.0-1-g1ff9ce680
'
2021-02-09 08:20:07.322 17 RALLYDEBUG rally.verification.utils [-] Subprocess output: '1ff9ce68013680c41243c5f9a9f0f3500bc5be49
'
2021-02-09 08:20:07.344 17 RALLYDEBUG rally.verification.manager [-] Checking system-wide packages for verifier.
2021-02-09 08:20:07.400 17 RALLYDEBUG rally.plugins.verification.testr [-] Initializing testr.
2021-02-09 08:20:08.162 17 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=21e0c181-5f05-412e-acba-f28699e54f63) has been successfully created!
2021-02-09 08:20:09.864 25 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:20:09.864 25 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:20:09.865 25 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:14.748 28 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:20:14.748 28 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:20:14.748 28 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:17.165 28 INFO rally.api [-] Configuring verifier 'opnfv-tempest' (UUID=21e0c181-5f05-412e-acba-f28699e54f63) for deployment 'opnfv-rally' (UUID=0d7ad343-eb1b-4339-943b-1fdc16fd2a0e).
2021-02-09 08:20:17.724 28 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=21e0c181-5f05-412e-acba-f28699e54f63) has been successfully configured for deployment 'opnfv-rally' (UUID=0d7ad343-eb1b-4339-943b-1fdc16fd2a0e)!
2021-02-09 08:20:26.727 32 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:20:26.728 32 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:20:26.728 32 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:20:29.148 32 INFO rally.api [-] Starting verification (UUID=6fe64975-10ae-4f14-a5b7-42988b822ed2) for deployment 'opnfv-rally' (UUID=0d7ad343-eb1b-4339-943b-1fdc16fd2a0e) by verifier 'opnfv-tempest' (UUID=21e0c181-5f05-412e-acba-f28699e54f63).
2021-02-09 08:20:30.152 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' from 'DEFAULT' section is not configured.
2021-02-09 08:20:30.152 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/for-deployment-0d7ad343-eb1b-4339-943b-1fdc16fd2a0e/tempest.log' to option 'log_file'.
2021-02-09 08:20:30.152 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' is configured. log_file = /root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/for-deployment-0d7ad343-eb1b-4339-943b-1fdc16fd2a0e/tempest.log
2021-02-09 08:20:30.153 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' from 'oslo_concurrency' section is not configured.
2021-02-09 08:20:30.153 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/for-deployment-0d7ad343-eb1b-4339-943b-1fdc16fd2a0e/lock_files' to option 'lock_path'.
2021-02-09 08:20:30.153 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' is configured. lock_path = /root/.rally/verification/verifier-21e0c181-5f05-412e-acba-f28699e54f63/for-deployment-0d7ad343-eb1b-4339-943b-1fdc16fd2a0e/lock_files
2021-02-09 08:20:30.154 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 08:20:30.154 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 08:20:30.155 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref' is already configured in Tempest config file. image_ref = dc814d2c-7071-4c52-ad43-bbf46c75b667
2021-02-09 08:20:30.155 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref_alt' is already configured in Tempest config file. image_ref_alt = 2188638c-4e6b-4268-a8de-047c48217ddb
2021-02-09 08:20:30.156 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref' is already configured in Tempest config file. flavor_ref = bde9ee81-0b61-4738-ab86-30bc30e2707d
2021-02-09 08:20:30.156 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref_alt' is already configured in Tempest config file. flavor_ref_alt = 280e52ac-6ebd-465c-916b-2ee0611f4595
2021-02-09 08:20:30.398 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Shared networks found. 'fixed_network_name' option should be configured.
2021-02-09 08:20:30.399 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'fixed_network_name' is already configured in Tempest config file. fixed_network_name = tempest_scenario-net_24ee7268-c8c1-4dcd-82a2-f8ed8e09ff6e
2021-02-09 08:20:30.400 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' from 'orchestration' section is not configured.
2021-02-09 08:20:30.473 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 08:20:30.515 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] The following flavor discovered: 'rally_verify_79d26574_6gZcU9jW'. Using flavor 'rally_verify_79d26574_6gZcU9jW' (ID = fd7b61f5-b668-4b5c-b025-a2d4fe7062d8) for the tests.
2021-02-09 08:20:30.515 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value 'fd7b61f5-b668-4b5c-b025-a2d4fe7062d8' to option 'instance_type'.
2021-02-09 08:20:30.515 32 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' is configured. instance_type = fd7b61f5-b668-4b5c-b025-a2d4fe7062d8
2021-02-09 08:20:30.516 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context tempest@default setup()  finished in 1.03 sec
2021-02-09 08:20:30.517 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context testr@default setup()  finished in 0.23 msec
2021-02-09 08:20:30.517 32 RALLYDEBUG rally.plugins.verification.testr [-] Test(s) started by the command: 'stestr run --subunit --serial --load-list /tmp/2fa2fba1-61bc-4887-b6b8-849525c20b77'.
2021-02-09 08:21:42.553 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_minimum_basic.TestMinimumBasicScenario.test_minimum_basic_scenario ... success [55.668s]
2021-02-09 08:22:52.716 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_network_basic_ops.TestNetworkBasicOps.test_hotplug_nic ... success [58.817s]
2021-02-09 08:24:10.834 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_network_basic_ops.TestNetworkBasicOps.test_network_basic_ops ... success [78.100s]
2021-02-09 08:24:13.711 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_object_storage_basic_ops.TestObjectStorageBasicOps.test_swift_basic_ops ... success [0.306s]
2021-02-09 08:25:47.319 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_security_groups_basic_ops.TestSecurityGroupsBasicOps.test_cross_tenant_traffic ... success [90.415s]
2021-02-09 08:26:55.375 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_security_groups_basic_ops.TestSecurityGroupsBasicOps.test_in_tenant_traffic ... success [68.039s]
2021-02-09 08:27:35.982 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_server_basic_ops.TestServerBasicOps.test_server_basic_ops ... success [32.629s]
2021-02-09 08:28:35.932 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_server_multinode.TestServerMultinode.test_schedule_to_all_nodes ... success [35.483s]
2021-02-09 08:29:08.951 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_boot_server_from_encrypted_volume_luks ... skip [0.000s]: b'Encrypted volume attach is not supported'
2021-02-09 08:29:49.649 32 INFO opnfv-tempest [-] {0} tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_image_defined_boot_from_volume ... success [40.681s]
2021-02-09 08:30:06.841 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context testr@default cleanup() started
2021-02-09 08:30:06.841 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context testr@default cleanup() finished in 0.63 msec
2021-02-09 08:30:06.842 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context tempest@default cleanup() started
2021-02-09 08:30:07.051 32 INFO rally.task.context [-] Verification 21e0c181-5f05-412e-acba-f28699e54f63 | Context tempest@default cleanup() finished in 0.21 sec
2021-02-09 08:30:07.082 32 INFO rally.api [-] Verification (UUID=6fe64975-10ae-4f14-a5b7-42988b822ed2) has been successfully finished for deployment 'opnfv-rally' (UUID=0d7ad343-eb1b-4339-943b-1fdc16fd2a0e)!
2021-02-09 08:30:08.942 145 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:30:08.943 145 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:30:08.943 145 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:30:10.566 146 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:30:10.566 146 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:30:10.567 146 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:30:12.963 146 INFO rally.api [-] Building 'html' report for the following verification(s): '6fe64975-10ae-4f14-a5b7-42988b822ed2'
2021-02-09 08:30:12.989 146 INFO rally.api [-] The report has been successfully built.
2021-02-09 08:30:14.667 148 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2021-02-09 08:30:14.668 148 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2021-02-09 08:30:14.668 148 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2021-02-09 08:30:16.795 148 INFO rally.api [-] Building 'junit-xml' report for the following verification(s): '6fe64975-10ae-4f14-a5b7-42988b822ed2'
2021-02-09 08:30:16.798 148 INFO rally.api [-] The report has been successfully built.
