2020-04-28 00:12:19.689 7 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:19.689 7 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:19.689 7 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:21.157 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-28 00:12:21.157 7 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/cliutils.py", line 657, in run
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "<decorator-gen-16>", line 2, in destroy
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/envutils.py", line 135, in default_from_global
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "<decorator-gen-15>", line 2, in destroy
2020-04-28 00:12:21.157 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-28 00:12:21.157 7 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/commands/deployment.py", line 154, in destroy
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     api.deployment.destroy(deployment=deployment)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 115, in destroy
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     deploy = objects.Deployment.get(deployment)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/objects/deploy.py", line 124, in get
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     return Deployment(env_mgr.EnvManager.get(deploy))
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/env/env_mgr.py", line 212, in get
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     return cls(db.env_get(uuid_or_name))
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 133, in wrapper
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 518, in env_get
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for uuid or name is opnfv-rally not found in table envs
2020-04-28 00:12:21.157 7 ERROR rally.cli.cliutils 
2020-04-28 00:12:22.359 9 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:22.359 9 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:22.359 9 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:25.400 11 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:25.400 11 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:25.400 11 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:28.769 14 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:28.769 14 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:28.769 14 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:29.919 17 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:29.919 17 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:29.919 17 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:31.524 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-28 00:12:31.524 17 ERROR rally.cli.cliutils Traceback (most recent call last):
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/cliutils.py", line 657, in run
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     ret = fn(*fn_args, **fn_kwargs)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "<decorator-gen-67>", line 2, in delete_verifier
2020-04-28 00:12:31.524 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-28 00:12:31.524 17 ERROR rally.cli.cliutils     return f(*args, **kwargs)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/cli/commands/verify.py", line 234, in delete_verifier
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     api.verifier.delete(verifier_id=verifier_id,
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 690, in delete
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     verifier = self._get(verifier_id)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/api.py", line 664, in _get
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     return objects.Verifier.get(verifier_id)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/objects/verifier.py", line 69, in get
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     return cls(db.verifier_get(verifier_id))
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 133, in wrapper
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     result = f(session, *args, **kwargs)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 667, in verifier_get
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     return _verifier_get(session, verifier_id)
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils   File "/usr/lib/python3.8/site-packages/rally/common/db/api.py", line 676, in _verifier_get
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils     raise exceptions.DBRecordNotFound(
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils rally.exceptions.DBRecordNotFound: Record for name or uuid is opnfv-tempest not found in table verifiers
2020-04-28 00:12:31.524 17 ERROR rally.cli.cliutils 
2020-04-28 00:12:32.894 19 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:32.895 19 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:32.895 19 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:34.630 19 INFO rally.api [-] Creating verifier 'opnfv-tempest'.
2020-04-28 00:12:34.692 19 RALLYDEBUG rally.verification.manager [-] Cloning verifier repo from /src/tempest into /root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/repo.
2020-04-28 00:12:34.897 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'Cloning into '/root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/repo'...
done.
'
2020-04-28 00:12:34.908 19 RALLYDEBUG rally.verification.utils [-] Subprocess output: 'heads/master
'
2020-04-28 00:12:34.927 19 RALLYDEBUG rally.verification.manager [-] Checking system-wide packages for verifier.
2020-04-28 00:12:34.974 19 RALLYDEBUG rally.plugins.verification.testr [-] Initializing testr.
2020-04-28 00:12:35.601 19 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=759cc77c-6870-4094-950e-1676c9567002) has been successfully created!
2020-04-28 00:12:36.952 26 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:36.953 26 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:36.953 26 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:40.778 29 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:40.779 29 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:40.779 29 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:42.453 29 INFO rally.api [-] Configuring verifier 'opnfv-tempest' (UUID=759cc77c-6870-4094-950e-1676c9567002) for deployment 'opnfv-rally' (UUID=173e125b-c0f0-40e6-80b0-810110a7f810).
2020-04-28 00:12:43.168 29 INFO rally.api [-] Verifier 'opnfv-tempest' (UUID=759cc77c-6870-4094-950e-1676c9567002) has been successfully configured for deployment 'opnfv-rally' (UUID=173e125b-c0f0-40e6-80b0-810110a7f810)!
2020-04-28 00:12:49.492 34 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:12:49.492 34 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:12:49.492 34 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:12:51.165 34 INFO rally.api [-] Starting verification (UUID=c9a1c94e-8ff2-435d-89b3-0c1309d0aac1) for deployment 'opnfv-rally' (UUID=173e125b-c0f0-40e6-80b0-810110a7f810) by verifier 'opnfv-tempest' (UUID=759cc77c-6870-4094-950e-1676c9567002).
2020-04-28 00:12:51.678 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' from 'DEFAULT' section is not configured.
2020-04-28 00:12:51.679 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/for-deployment-173e125b-c0f0-40e6-80b0-810110a7f810/tempest.log' to option 'log_file'.
2020-04-28 00:12:51.679 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'log_file' is configured. log_file = /root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/for-deployment-173e125b-c0f0-40e6-80b0-810110a7f810/tempest.log
2020-04-28 00:12:51.679 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' from 'oslo_concurrency' section is not configured.
2020-04-28 00:12:51.680 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '/root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/for-deployment-173e125b-c0f0-40e6-80b0-810110a7f810/lock_files' to option 'lock_path'.
2020-04-28 00:12:51.680 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'lock_path' is configured. lock_path = /root/.rally/verification/verifier-759cc77c-6870-4094-950e-1676c9567002/for-deployment-173e125b-c0f0-40e6-80b0-810110a7f810/lock_files
2020-04-28 00:12:51.680 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-28 00:12:51.681 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-28 00:12:51.681 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref' is already configured in Tempest config file. image_ref = 6446e3cb-1268-451e-99f6-643c5003d99b
2020-04-28 00:12:51.681 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'image_ref_alt' is already configured in Tempest config file. image_ref_alt = c1d12740-1e94-4a97-a875-0351a6d03471
2020-04-28 00:12:51.682 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref' is already configured in Tempest config file. flavor_ref = 2d0b1e9f-cbd8-4e39-82ba-a21cf0719626
2020-04-28 00:12:51.682 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'flavor_ref_alt' is already configured in Tempest config file. flavor_ref_alt = 369e2833-43f7-4c60-9d27-8c4d06ecf18c
2020-04-28 00:12:52.297 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Shared networks found. 'fixed_network_name' option should be configured.
2020-04-28 00:12:52.297 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'fixed_network_name' is already configured in Tempest config file. fixed_network_name = barbican-net_4f17b54d-2c9b-43fb-9adb-95f0eab784c6
2020-04-28 00:12:52.298 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' from 'orchestration' section is not configured.
2020-04-28 00:12:52.372 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Trying to discover a flavor with the following properties: RAM = 64MB, VCPUs = 1, disk >= 5GiB.
2020-04-28 00:12:52.404 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] There is no flavor with the mentioned properties.
2020-04-28 00:12:52.405 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Creating flavor 'rally_verify_c9a1c94e_CFLxsN3K' with the following properties: RAM = 64MB, VCPUs = 1, disk = 5GB.
2020-04-28 00:12:52.438 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Flavor 'rally_verify_c9a1c94e_CFLxsN3K' (ID = 91cbb460-dd37-47ad-b820-aa944aeb24ad) has been successfully created!
2020-04-28 00:12:52.438 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Setting value '91cbb460-dd37-47ad-b820-aa944aeb24ad' to option 'instance_type'.
2020-04-28 00:12:52.438 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Option 'instance_type' is configured. instance_type = 91cbb460-dd37-47ad-b820-aa944aeb24ad
2020-04-28 00:12:52.440 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context tempest@default setup()  finished in 1.13 sec
2020-04-28 00:12:52.441 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context testr@default setup()  finished in 0.42 msec
2020-04-28 00:12:52.441 34 RALLYDEBUG rally.plugins.verification.testr [-] Test(s) started by the command: 'stestr run --subunit --load-list /tmp/6bf7541e-f75b-49d8-a930-e350b7036273'.
2020-04-28 00:12:56.992 34 INFO opnfv-tempest [-] {7} barbican_tempest_plugin.tests.scenario.test_volume_encryption.VolumeEncryptionTest ... skip: b'Encrypted volume attach is not supported'
2020-04-28 00:12:56.999 34 INFO opnfv-tempest [-] {9} barbican_tempest_plugin.tests.test_barbican_tempest_plugin.TestBarbican_tempest_plugin.test_something ... success [0.000s]
2020-04-28 00:13:21.053 34 INFO opnfv-tempest [-] {8} barbican_tempest_plugin.tests.api.test_consumers.ConsumersTest.test_add_delete_consumers_in_container ... success [0.540s]
2020-04-28 00:13:22.986 34 INFO opnfv-tempest [-] {4} barbican_tempest_plugin.tests.api.test_secret_metadata.SecretMetadataTest.test_secret_metadata ... success [0.492s]
2020-04-28 00:13:24.282 34 INFO opnfv-tempest [-] {0} barbican_tempest_plugin.tests.api.test_containers.ContainersTest.test_add_to_delete_from_container ... success [0.566s]
2020-04-28 00:13:24.386 34 INFO opnfv-tempest [-] {0} barbican_tempest_plugin.tests.api.test_containers.ContainersTest.test_create_list_delete_empty_container ... success [0.104s]
2020-04-28 00:13:24.886 34 INFO opnfv-tempest [-] {6} barbican_tempest_plugin.tests.api.test_orders.OrdersTest.test_create_list_delete_orders ... success [0.470s]
2020-04-28 00:13:24.932 34 INFO opnfv-tempest [-] {10} barbican_tempest_plugin.tests.api.test_quotas.QuotasTest.test_create_get_delete_quota ... success [0.206s]
2020-04-28 00:13:25.522 34 INFO opnfv-tempest [-] {5} barbican_tempest_plugin.tests.api.test_secrets.SecretsTest.test_create_delete_empty_secret ... success [0.222s]
2020-04-28 00:13:25.614 34 INFO opnfv-tempest [-] {5} barbican_tempest_plugin.tests.api.test_secrets.SecretsTest.test_create_delete_symmetric_key ... success [0.091s]
2020-04-28 00:13:25.806 34 INFO opnfv-tempest [-] {5} barbican_tempest_plugin.tests.api.test_secrets.SecretsTest.test_get_and_put_payload ... success [0.192s]
2020-04-28 00:13:25.926 34 INFO opnfv-tempest [-] {5} barbican_tempest_plugin.tests.api.test_secrets.SecretsTest.test_get_secret_metadata ... success [0.120s]
2020-04-28 00:13:26.044 34 INFO opnfv-tempest [-] {5} barbican_tempest_plugin.tests.api.test_secrets.SecretsTest.test_list_secrets ... success [0.117s]
2020-04-28 00:13:28.994 34 INFO opnfv-tempest [-] {2} barbican_tempest_plugin.tests.scenario.test_image_signing.ImageSigningSnapshotTest.test_signed_image_upload_boot_snapshot ... success [27.809s]
2020-04-28 00:13:41.599 34 INFO opnfv-tempest [-] {3} barbican_tempest_plugin.tests.scenario.test_image_signing.ImageSigningTest.test_signed_image_upload_and_boot ... success [15.333s]
2020-04-28 00:13:42.783 34 INFO opnfv-tempest [-] {1} barbican_tempest_plugin.tests.scenario.test_ephemeral_disk_encryption.EphemeralStorageEncryptionTest.test_encrypted_ephemeral_lvm_storage ... success [23.836s]
2020-04-28 00:13:53.531 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context testr@default cleanup() started
2020-04-28 00:13:53.531 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context testr@default cleanup() finished in 0.72 msec
2020-04-28 00:13:53.532 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context tempest@default cleanup() started
2020-04-28 00:13:53.702 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Deleting flavor 'rally_verify_c9a1c94e_CFLxsN3K'.
2020-04-28 00:13:53.965 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Flavor 'rally_verify_c9a1c94e_CFLxsN3K' has been deleted.
2020-04-28 00:13:53.967 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Removing value '91cbb460-dd37-47ad-b820-aa944aeb24ad' of option 'instance_type' from Tempest config file.
2020-04-28 00:13:53.967 34 RALLYDEBUG rally_openstack.verification.tempest.context [-] Value '91cbb460-dd37-47ad-b820-aa944aeb24ad' has been removed.
2020-04-28 00:13:53.972 34 INFO rally.task.context [-] Verification 759cc77c-6870-4094-950e-1676c9567002 | Context tempest@default cleanup() finished in 0.44 sec
2020-04-28 00:13:54.004 34 INFO rally.api [-] Verification (UUID=c9a1c94e-8ff2-435d-89b3-0c1309d0aac1) has been successfully finished for deployment 'opnfv-rally' (UUID=173e125b-c0f0-40e6-80b0-810110a7f810)!
2020-04-28 00:13:55.478 76 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:13:55.479 76 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:13:55.479 76 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:13:56.744 78 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:13:56.744 78 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:13:56.744 78 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:13:58.382 78 INFO rally.api [-] Building 'html' report for the following verification(s): 'c9a1c94e-8ff2-435d-89b3-0c1309d0aac1'
2020-04-28 00:13:58.397 78 INFO rally.api [-] The report has been successfully built.
2020-04-28 00:13:59.638 80 RALLYDEBUG rally.api [-] INFO logs from urllib3 and requests module are hide.
2020-04-28 00:13:59.638 80 RALLYDEBUG rally.api [-] urllib3 insecure warnings are hidden.
2020-04-28 00:13:59.638 80 RALLYDEBUG rally.api [-] ERROR log from boto module is hide.
2020-04-28 00:14:01.151 80 INFO rally.api [-] Building 'junit-xml' report for the following verification(s): 'c9a1c94e-8ff2-435d-89b3-0c1309d0aac1'
2020-04-28 00:14:01.153 80 INFO rally.api [-] The report has been successfully built.
