docs/results/compass-os-onos-nofeature-ha.rst

   1 .. This work is licensed under a Creative Commons Attribution 4.0 International Licence.
   2 .. http://creativecommons.org/licenses/by/4.0
   3
   4 Detailed test results for compass-os-onos-nofeature-ha
   5 ======================================================
   6
   7 Running test case: vping_ssh
   8 -----------------------------
   9
  10 ::
  11   FUNCTEST.info: Running vPing-SSH test...
  12   2016-02-12 19:05:40,043 - vPing_ssh- DEBUG - Creating image 'functest-vping' from '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img'...
  13   2016-02-12 19:05:41,030 - vPing_ssh- DEBUG - Image 'functest-vping' with ID=60da5df9-daa1-47de-816f-b9886ab67d71 created successfully.
  14   2016-02-12 19:05:41,076 - vPing_ssh- INFO - Creating neutron network vping-net...
  15   2016-02-12 19:05:41,354 - vPing_ssh- DEBUG - Network 'd45d7f71-10bf-45b1-9d86-94425f8fe21c' created successfully
  16   2016-02-12 19:05:41,355 - vPing_ssh- DEBUG - Creating Subnet....
  17   2016-02-12 19:05:41,634 - vPing_ssh- DEBUG - Subnet 'ad01de12-9720-40e8-b5ec-3e59c3a783d3' created successfully
  18   2016-02-12 19:05:41,634 - vPing_ssh- DEBUG - Creating Router...
  19   2016-02-12 19:05:41,687 - vPing_ssh- DEBUG - Router '7196b873-8686-4940-b169-7c004f5a48dc' created successfully
  20   2016-02-12 19:05:41,687 - vPing_ssh- DEBUG - Adding router to subnet...
  21   2016-02-12 19:05:41,922 - vPing_ssh- DEBUG - Interface added successfully.
  22   2016-02-12 19:05:41,922 - vPing_ssh- DEBUG - Adding gateway to router...
  23   2016-02-12 19:05:42,396 - vPing_ssh- DEBUG - Gateway added successfully.
  24   2016-02-12 19:05:42,741 - vPing_ssh- INFO - Flavor found 'm1.small'
  25   2016-02-12 19:05:43,450 - vPing_ssh- INFO - Creating security group  'vPing-sg'...
  26   2016-02-12 19:05:43,567 - vPing_ssh- DEBUG - Security group 'vPing-sg' with ID=93ac4559-82df-4b73-9eef-0a4d2a2d7b6e created successfully.
  27   2016-02-12 19:05:43,567 - vPing_ssh- DEBUG - Adding ICMP rules in security group 'vPing-sg'...
  28   2016-02-12 19:05:43,724 - vPing_ssh- DEBUG - Adding SSH rules in security group 'vPing-sg'...
  29   2016-02-12 19:05:44,008 - vPing_ssh- INFO - vPing Start Time:'2016-02-12 19:05:44'
  30   2016-02-12 19:05:44,008 - vPing_ssh- DEBUG - Creating port 'vping-port-1' with IP 192.168.130.30...
  31   2016-02-12 19:05:44,510 - vPing_ssh- INFO - Creating instance 'opnfv-vping-1' with IP 192.168.130.30...
  32   2016-02-12 19:05:44,510 - vPing_ssh- DEBUG - Configuration:
  33    name=opnfv-vping-1
  34    flavor=<Flavor: m1.small>
  35    image=60da5df9-daa1-47de-816f-b9886ab67d71
  36    network=d45d7f71-10bf-45b1-9d86-94425f8fe21c
  37
  38   2016-02-12 19:05:46,752 - vPing_ssh- DEBUG - Status: BUILD
  39   2016-02-12 19:05:49,993 - vPing_ssh- DEBUG - Status: BUILD
  40   2016-02-12 19:05:53,271 - vPing_ssh- DEBUG - Status: ACTIVE
  41   2016-02-12 19:05:53,271 - vPing_ssh- INFO - Instance 'opnfv-vping-1' is ACTIVE.
  42   2016-02-12 19:05:53,271 - vPing_ssh- DEBUG - Instance 'opnfv-vping-1' got 192.168.130.30
  43   2016-02-12 19:05:53,271 - vPing_ssh- INFO - Adding 'opnfv-vping-1' to security group 'vPing-sg'...
  44   2016-02-12 19:05:53,924 - vPing_ssh- DEBUG - Creating port 'vping-port-2' with IP 192.168.130.40...
  45   2016-02-12 19:05:54,241 - vPing_ssh- INFO - Creating instance 'opnfv-vping-2' with IP 192.168.130.40...
  46   2016-02-12 19:05:54,241 - vPing_ssh- DEBUG - Configuration:
  47    name=opnfv-vping-2
  48    flavor=<Flavor: m1.small>
  49    image=60da5df9-daa1-47de-816f-b9886ab67d71
  50    network=d45d7f71-10bf-45b1-9d86-94425f8fe21c
  51
  52   2016-02-12 19:05:56,816 - vPing_ssh- DEBUG - Status: BUILD
  53   2016-02-12 19:06:00,048 - vPing_ssh- DEBUG - Status: ACTIVE
  54   2016-02-12 19:06:00,048 - vPing_ssh- INFO - Instance 'opnfv-vping-2' is ACTIVE.
  55   2016-02-12 19:06:00,048 - vPing_ssh- INFO - Adding 'opnfv-vping-2' to security group 'vPing-sg'...
  56   2016-02-12 19:06:00,391 - vPing_ssh- INFO - Creating floating IP for VM 'opnfv-vping-2'...
  57   2016-02-12 19:06:00,625 - vPing_ssh- INFO - Floating IP created: '192.168.10.102'
  58   2016-02-12 19:06:00,625 - vPing_ssh- INFO - Associating floating ip: '192.168.10.102' to VM 'opnfv-vping-2'
  59   2016-02-12 19:06:01,848 - vPing_ssh- INFO - Trying to establish SSH connection to 192.168.10.102...
  60   2016-02-12 19:06:01,850 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  61   2016-02-12 19:06:07,856 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  62   2016-02-12 19:06:13,864 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  63   2016-02-12 19:06:19,872 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  64   2016-02-12 19:06:25,879 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  65   2016-02-12 19:06:31,884 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  66   2016-02-12 19:06:37,892 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  67   2016-02-12 19:06:43,899 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  68   2016-02-12 19:06:49,906 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  69   2016-02-12 19:06:55,913 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  70   2016-02-12 19:07:01,920 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  71   2016-02-12 19:07:07,925 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  72   2016-02-12 19:07:13,933 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  73   2016-02-12 19:07:19,940 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  74   2016-02-12 19:07:25,948 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  75   2016-02-12 19:07:31,955 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  76   2016-02-12 19:07:37,962 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  77   2016-02-12 19:07:43,964 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  78   2016-02-12 19:07:49,971 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  79   2016-02-12 19:07:55,978 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  80   2016-02-12 19:08:01,983 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  81   2016-02-12 19:08:07,990 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  82   2016-02-12 19:08:13,997 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  83   2016-02-12 19:08:20,004 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  84   2016-02-12 19:08:26,012 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  85   2016-02-12 19:08:32,019 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  86   2016-02-12 19:08:38,026 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  87   2016-02-12 19:08:44,032 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  88   2016-02-12 19:08:50,039 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  89   2016-02-12 19:08:56,047 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  90   2016-02-12 19:09:02,050 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  91   2016-02-12 19:09:08,058 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  92   2016-02-12 19:09:14,065 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  93   2016-02-12 19:09:20,072 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  94   2016-02-12 19:09:26,080 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  95   2016-02-12 19:09:32,087 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  96   2016-02-12 19:09:38,094 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  97   2016-02-12 19:09:44,101 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  98   2016-02-12 19:09:50,109 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
  99   2016-02-12 19:09:56,116 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
 100   2016-02-12 19:10:02,123 - vPing_ssh- DEBUG - Waiting for 192.168.10.102...
 101   2016-02-12 19:10:08,257 - vPing_ssh- DEBUG - SSH connection established to 192.168.10.102.
 102   2016-02-12 19:10:09,335 - vPing_ssh- INFO - Waiting for ping...
 103   2016-02-12 19:10:10,344 - vPing_ssh- INFO - vPing detected!
 104   2016-02-12 19:10:10,344 - vPing_ssh- INFO - vPing duration:'266.3' s.
 105   2016-02-12 19:10:10,344 - vPing_ssh- INFO - Cleaning up...
 106   2016-02-12 19:10:10,344 - vPing_ssh- DEBUG - Deleting image...
 107   2016-02-12 19:10:11,945 - vPing_ssh- DEBUG - Deleting 'opnfv-vping-1'...
 108   2016-02-12 19:10:16,110 - vPing_ssh- DEBUG - Instance opnfv-vping-1 terminated.
 109   2016-02-12 19:10:16,350 - vPing_ssh- DEBUG - Deleting 'opnfv-vping-2'...
 110   2016-02-12 19:10:21,539 - vPing_ssh- DEBUG - Instance opnfv-vping-2 terminated.
 111   2016-02-12 19:10:21,539 - vPing_ssh- DEBUG - Deleting network 'vping-net'...
 112   2016-02-12 19:10:21,730 - vPing_ssh- DEBUG - Port '23ea5cbc-d075-4f75-8839-55877d217d09' removed successfully
 113   2016-02-12 19:10:21,903 - vPing_ssh- DEBUG - Port '1cbcac3d-fea8-4ca1-98d7-4c2b6d2a655b' removed successfully
 114   2016-02-12 19:10:22,121 - vPing_ssh- DEBUG - Interface removed successfully
 115   2016-02-12 19:10:22,341 - vPing_ssh- DEBUG - Router deleted successfully
 116   2016-02-12 19:10:22,569 - vPing_ssh- DEBUG - Subnet 'vping-subnet' deleted successfully
 117   2016-02-12 19:10:22,801 - vPing_ssh- DEBUG - Network 'vping-net' deleted successfully
 118   2016-02-12 19:10:22,851 - vPing_ssh- DEBUG - Security group '93ac4559-82df-4b73-9eef-0a4d2a2d7b6e' deleted successfully
 119   2016-02-12 19:10:22,851 - vPing_ssh- INFO - vPing OK
 120   2016-02-12 19:10:22,851 - vPing_ssh- DEBUG - Pushing result into DB...
 121   2016-02-12 19:10:23,533 - vPing_ssh- DEBUG - <Response [200]>
 122 ::
 123
 124 Running test case: tempest
 125 --------------------------
 126 ::
 127   FUNCTEST.info: Running Tempest tests...
 128   2016-02-12 19:10:23,939 - run_tempest - INFO - Creating tenant and user for Tempest suite
 129   2016-02-12 19:10:24,296 - run_tempest - DEBUG - Generating tempest.conf file...
 130   2016-02-12 19:10:24,296 - run_tempest - DEBUG - Executing command : rally verify genconfig
 131   2016-02-12 19:10:29,268 - run_tempest - DEBUG - 2016-02-12 19:10:24.832 23856 INFO rally.verification.tempest.tempest [-] Tempest is not configured.
 132   2016-02-12 19:10:24.832 23856 INFO rally.verification.tempest.tempest [-] Starting: Creating configuration file for Tempest.
 133   2016-02-12 19:10:29.226 23856 INFO rally.verification.tempest.tempest [-] Completed: Creating configuration file for Tempest.
 134
 135   2016-02-12 19:10:29,268 - run_tempest - DEBUG - Resolving deployment UUID...
 136   2016-02-12 19:10:29,837 - run_tempest - DEBUG - Finding tempest.conf file...
 137   2016-02-12 19:10:29,837 - run_tempest - DEBUG -   Updating fixed_network_name...
 138   2016-02-12 19:10:30,116 - run_tempest - DEBUG - Executing command : crudini --set /home/opnfv/.rally/tempest/for-deployment-ea712793-ba5c-425c-adcb-f830168264e4/tempest.conf compute fixed_network_name functest-net
 139   2016-02-12 19:10:30,146 - run_tempest - DEBUG -   Updating non-admin credentials...
 140   2016-02-12 19:10:30,146 - run_tempest - DEBUG - Executing command : crudini --set /home/opnfv/.rally/tempest/for-deployment-ea712793-ba5c-425c-adcb-f830168264e4/tempest.conf identity tenant_name tempest
 141   2016-02-12 19:10:30,182 - run_tempest - DEBUG - Executing command : crudini --set /home/opnfv/.rally/tempest/for-deployment-ea712793-ba5c-425c-adcb-f830168264e4/tempest.conf identity username tempest
 142   2016-02-12 19:10:30,210 - run_tempest - DEBUG - Executing command : crudini --set /home/opnfv/.rally/tempest/for-deployment-ea712793-ba5c-425c-adcb-f830168264e4/tempest.conf identity password tempest
 143   2016-02-12 19:10:30,242 - run_tempest - DEBUG - Executing command : sed -i 's/.*ssh_user_regex.*/ssh_user_regex = [["^.*[Cc]irros.*$", "cirros"], ["^.*[Tt]est[VvMm].*$", "cirros"], ["^.*rally_verify.*$", "cirros"]]/' /home/opnfv/.rally/tempest/for-deployment-ea712793-ba5c-425c-adcb-f830168264e4/tempest.conf
 144   2016-02-12 19:10:30,247 - run_tempest - INFO - Starting Tempest test suite: '--tests-file /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/custom_tests/test_list.txt'.
 145   2016-02-12 19:10:30,247 - run_tempest - DEBUG - Executing command : rally verify start --tests-file /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/custom_tests/test_list.txt
 146   Total results of verification:
 147
 148   +--------------------------------------+--------------------------------------+----------+-------+----------+----------------------------+----------+
 149   | UUID                                 | Deployment UUID                      | Set name | Tests | Failures | Created at                 | Status   |
 150   +--------------------------------------+--------------------------------------+----------+-------+----------+----------------------------+----------+
 151   | 818d3bed-1209-4161-a009-d67b5d4b1a5b | ea712793-ba5c-425c-adcb-f830168264e4 |          | 210   | 11       | 2016-02-12 19:10:30.775632 | finished |
 152   +--------------------------------------+--------------------------------------+----------+-------+----------+----------------------------+----------+
 153
 154   Tests:
 155
 156   +------------------------------------------------------------------------------------------------------------------------------------------+-----------+---------+
 157   | name                                                                                                                                     | time      | status  |
 158   +------------------------------------------------------------------------------------------------------------------------------------------+-----------+---------+
 159   | tempest.api.compute.flavors.test_flavors.FlavorsV2TestJSON.test_get_flavor                                                               | 0.38798   | success |
 160   | tempest.api.compute.flavors.test_flavors.FlavorsV2TestJSON.test_list_flavors                                                             | 0.06897   | success |
 161   | tempest.api.compute.images.test_images.ImagesTestJSON.test_delete_saving_image                                                           | 8.66954   | success |
 162   | tempest.api.compute.images.test_images_oneserver.ImagesOneServerTestJSON.test_create_delete_image                                        | 13.05485  | success |
 163   | tempest.api.compute.images.test_images_oneserver.ImagesOneServerTestJSON.test_create_image_specify_multibyte_character_image_name        | 8.17642   | success |
 164   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_changes_since                     | 0.06398   | success |
 165   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_name                              | 0.05311   | success |
 166   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_server_id                         | 0.06698   | success |
 167   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_server_ref                        | 0.12086   | success |
 168   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_status                            | 0.07949   | success |
 169   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_filter_by_type                              | 0.06849   | success |
 170   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_limit_results                               | 0.06627   | success |
 171   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_filter_by_changes_since         | 0.06681   | success |
 172   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_filter_by_name                  | 0.05412   | success |
 173   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_filter_by_server_ref            | 0.17846   | success |
 174   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_filter_by_status                | 0.07675   | success |
 175   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_filter_by_type                  | 0.10191   | success |
 176   | tempest.api.compute.images.test_list_image_filters.ListImageFiltersTestJSON.test_list_images_with_detail_limit_results                   | 0.06990   | success |
 177   | tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_get_image                                                            | 0.15930   | success |
 178   | tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_list_images                                                          | 0.10904   | success |
 179   | tempest.api.compute.images.test_list_images.ListImagesTestJSON.test_list_images_with_detail                                              | 0.10306   | success |
 180   | tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_create                | 0.32255   | success |
 181   | tempest.api.compute.security_groups.test_security_group_rules.SecurityGroupRulesTestJSON.test_security_group_rules_list                  | 0.56048   | success |
 182   | tempest.api.compute.security_groups.test_security_groups.SecurityGroupsTestJSON.test_security_groups_create_list_delete                  | 1.42311   | success |
 183   | tempest.api.compute.servers.test_attach_interfaces.AttachInterfacesTestJSON.test_add_remove_fixed_ip                                     | 7.28776   | success |
 184   | tempest.api.compute.servers.test_create_server.ServersTestJSON.test_host_name_is_same_as_server_name                                     | 337.23588 | fail    |
 185   | tempest.api.compute.servers.test_create_server.ServersTestJSON.test_list_servers                                                         | 0.13741   | success |
 186   | tempest.api.compute.servers.test_create_server.ServersTestJSON.test_list_servers_with_detail                                             | 0.23680   | success |
 187   | tempest.api.compute.servers.test_create_server.ServersTestJSON.test_verify_created_server_vcpus                                          | 316.30761 | fail    |
 188   | tempest.api.compute.servers.test_create_server.ServersTestJSON.test_verify_server_details                                                | 0.00084   | success |
 189   | tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_host_name_is_same_as_server_name                               | 319.97246 | fail    |
 190   | tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_list_servers                                                   | 0.12007   | success |
 191   | tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_list_servers_with_detail                                       | 0.22505   | success |
 192   | tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_verify_created_server_vcpus                                    | 322.15364 | fail    |
 193   | tempest.api.compute.servers.test_create_server.ServersTestManualDisk.test_verify_server_details                                          | 0.00083   | success |
 194   | tempest.api.compute.servers.test_instance_actions.InstanceActionsTestJSON.test_get_instance_action                                       | 0.06292   | success |
 195   | tempest.api.compute.servers.test_instance_actions.InstanceActionsTestJSON.test_list_instance_actions                                     | 3.00411   | success |
 196   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_detailed_filter_by_flavor               | 0.20017   | success |
 197   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_detailed_filter_by_image                | 0.19477   | success |
 198   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_detailed_filter_by_server_name          | 0.14907   | success |
 199   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_detailed_filter_by_server_status        | 0.22243   | success |
 200   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_detailed_limit_results                  | 0.15516   | success |
 201   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filter_by_flavor                        | 0.07558   | success |
 202   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filter_by_image                         | 0.06317   | success |
 203   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filter_by_limit                         | 0.05484   | success |
 204   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filter_by_server_name                   | 0.06197   | success |
 205   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filter_by_server_status                 | 0.05894   | success |
 206   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filtered_by_ip                          | 0.19611   | success |
 207   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filtered_by_ip_regex                    | 0.00056   | skip    |
 208   | tempest.api.compute.servers.test_list_server_filters.ListServerFiltersTestJSON.test_list_servers_filtered_by_name_wildcard               | 0.13860   | success |
 209   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_changes_since_future_date        | 0.05872   | success |
 210   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_changes_since_invalid_date       | 0.01695   | success |
 211   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_limits                           | 0.07035   | success |
 212   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_limits_greater_than_actual_count | 0.21809   | success |
 213   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_limits_pass_negative_value       | 0.01841   | success |
 214   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_limits_pass_string               | 0.01089   | success |
 215   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_non_existing_flavor              | 0.02861   | success |
 216   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_non_existing_image               | 0.05638   | success |
 217   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_by_non_existing_server_name         | 0.05798   | success |
 218   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_detail_server_is_deleted            | 0.30626   | success |
 219   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_status_non_existing                 | 0.01272   | success |
 220   | tempest.api.compute.servers.test_list_servers_negative.ListServersNegativeTestJSON.test_list_servers_with_a_deleted_server               | 0.06264   | success |
 221   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_change_server_password                                        | 0.00050   | skip    |
 222   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_get_console_output                                            | 5.67273   | success |
 223   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_lock_unlock_server                                            | 9.07361   | success |
 224   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_reboot_server_hard                                            | 310.89730 | fail    |
 225   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_reboot_server_soft                                            | 0.39781   | skip    |
 226   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_rebuild_server                                                | 327.97278 | fail    |
 227   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_resize_server_confirm                                         | 13.09878  | success |
 228   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_resize_server_revert                                          | 19.25586  | success |
 229   | tempest.api.compute.servers.test_server_actions.ServerActionsTestJSON.test_stop_start_server                                             | 6.97419   | success |
 230   | tempest.api.compute.servers.test_server_addresses.ServerAddressesTestJSON.test_list_server_addresses                                     | 0.05925   | success |
 231   | tempest.api.compute.servers.test_server_addresses.ServerAddressesTestJSON.test_list_server_addresses_by_network                          | 0.13748   | success |
 232   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_delete_server_metadata_item                                 | 0.48860   | success |
 233   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_get_server_metadata_item                                    | 0.51186   | success |
 234   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_list_server_metadata                                        | 0.27618   | success |
 235   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_set_server_metadata                                         | 1.44356   | success |
 236   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_set_server_metadata_item                                    | 0.56153   | success |
 237   | tempest.api.compute.servers.test_server_metadata.ServerMetadataTestJSON.test_update_server_metadata                                      | 0.61749   | success |
 238   | tempest.api.compute.servers.test_servers.ServersTestJSON.test_create_server_with_admin_password                                          | 2.23577   | success |
 239   | tempest.api.compute.servers.test_servers.ServersTestJSON.test_create_specify_keypair                                                     | 14.27026  | success |
 240   | tempest.api.compute.servers.test_servers.ServersTestJSON.test_create_with_existing_server_name                                           | 13.23885  | success |
 241   | tempest.api.compute.servers.test_servers.ServersTestJSON.test_update_access_server_address                                               | 8.66286   | success |
 242   | tempest.api.compute.servers.test_servers.ServersTestJSON.test_update_server_name                                                         | 5.49453   | success |
 243   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_numeric_server_name                                | 0.50988   | success |
 244   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_server_metadata_exceeds_length_limit               | 0.58228   | success |
 245   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_server_name_length_exceeds_256                     | 0.73942   | success |
 246   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_with_invalid_flavor                                | 1.62280   | success |
 247   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_with_invalid_image                                 | 1.40931   | success |
 248   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_create_with_invalid_network_uuid                          | 1.41580   | success |
 249   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_delete_a_server_of_another_tenant                         | 0.50300   | success |
 250   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_delete_server_pass_id_exceeding_length_limit              | 0.39170   | success |
 251   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_delete_server_pass_negative_id                            | 0.41128   | success |
 252   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_get_non_existent_server                                   | 0.48554   | success |
 253   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_invalid_ip_v6_address                                     | 0.56803   | success |
 254   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_reboot_non_existent_server                                | 0.50901   | success |
 255   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_rebuild_non_existent_server                               | 0.58968   | success |
 256   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_resize_server_with_non_existent_flavor                    | 0.47930   | success |
 257   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_resize_server_with_null_flavor                            | 0.34199   | success |
 258   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_server_name_blank                                         | 0.57965   | success |
 259   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_stop_non_existent_server                                  | 0.41263   | success |
 260   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_update_name_of_non_existent_server                        | 1.07127   | success |
 261   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_update_server_name_length_exceeds_256                     | 0.34228   | success |
 262   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_update_server_of_another_tenant                           | 0.43989   | success |
 263   | tempest.api.compute.servers.test_servers_negative.ServersNegativeTestJSON.test_update_server_set_empty_name                              | 0.30970   | success |
 264   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_create_keypair_in_analt_user_tenant                                    | 0.10400   | success |
 265   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_create_server_fails_when_tenant_incorrect                              | 0.01156   | success |
 266   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_create_server_with_unauthorized_image                                  | 0.08172   | success |
 267   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_get_keypair_of_alt_account_fails                                       | 0.02068   | success |
 268   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_get_metadata_of_alt_account_server_fails                               | 0.54532   | success |
 269   | tempest.api.compute.test_authorization.AuthorizationTestJSON.test_set_metadata_of_alt_account_server_fails                               | 0.18789   | success |
 270   | tempest.api.compute.test_quotas.QuotasTestJSON.test_get_default_quotas                                                                   | 0.12172   | success |
 271   | tempest.api.compute.test_quotas.QuotasTestJSON.test_get_quotas                                                                           | 0.05132   | success |
 272   | tempest.api.compute.volumes.test_attach_volume.AttachVolumeTestJSON.test_attach_detach_volume                                            | 339.95221 | fail    |
 273   | tempest.api.compute.volumes.test_volumes_list.VolumesTestJSON.test_volume_list                                                           | 0.07032   | success |
 274   | tempest.api.compute.volumes.test_volumes_list.VolumesTestJSON.test_volume_list_with_details                                              | 0.06840   | success |
 275   | tempest.api.compute.volumes.test_volumes_negative.VolumesNegativeTest.test_get_invalid_volume_id                                         | 0.13918   | success |
 276   | tempest.api.compute.volumes.test_volumes_negative.VolumesNegativeTest.test_get_volume_without_passing_volume_id                          | 0.01148   | success |
 277   | tempest.api.identity.admin.v2.test_services.ServicesTestJSON.test_list_services                                                          | 0.22616   | success |
 278   | tempest.api.identity.admin.v2.test_users.UsersTestJSON.test_create_user                                                                  | 0.11317   | success |
 279   | tempest.api.identity.admin.v3.test_credentials.CredentialsTestJSON.test_credentials_create_get_update_delete                             | 0.14866   | success |
 280   | tempest.api.identity.admin.v3.test_domains.DefaultDomainTestJSON.test_default_domain_exists                                              | 0.02954   | success |
 281   | tempest.api.identity.admin.v3.test_domains.DomainsTestJSON.test_create_update_delete_domain                                              | 0.43616   | success |
 282   | tempest.api.identity.admin.v3.test_endpoints.EndPointsTestJSON.test_update_endpoint                                                      | 0.19924   | success |
 283   | tempest.api.identity.admin.v3.test_groups.GroupsV3TestJSON.test_group_users_add_list_delete                                              | 0.82300   | success |
 284   | tempest.api.identity.admin.v3.test_policies.PoliciesTestJSON.test_create_update_delete_policy                                            | 0.11213   | success |
 285   | tempest.api.identity.admin.v3.test_regions.RegionsTestJSON.test_create_region_with_specific_id                                           | 0.08933   | success |
 286   | tempest.api.identity.admin.v3.test_roles.RolesV3TestJSON.test_role_create_update_get_list                                                | 0.15558   | success |
 287   | tempest.api.identity.admin.v3.test_services.ServicesTestJSON.test_create_update_get_service                                              | 0.14961   | success |
 288   | tempest.api.identity.admin.v3.test_trusts.TrustsV3TestJSON.test_get_trusts_all                                                           | 0.76717   | success |
 289   | tempest.api.identity.v2.test_api_discovery.TestApiDiscovery.test_api_media_types                                                         | 0.02573   | success |
 290   | tempest.api.identity.v2.test_api_discovery.TestApiDiscovery.test_api_version_resources                                                   | 0.01676   | success |
 291   | tempest.api.identity.v2.test_api_discovery.TestApiDiscovery.test_api_version_statuses                                                    | 0.02202   | success |
 292   | tempest.api.identity.v3.test_api_discovery.TestApiDiscovery.test_api_media_types                                                         | 0.02597   | success |
 293   | tempest.api.identity.v3.test_api_discovery.TestApiDiscovery.test_api_version_resources                                                   | 0.01541   | success |
 294   | tempest.api.identity.v3.test_api_discovery.TestApiDiscovery.test_api_version_statuses                                                    | 0.01451   | success |
 295   | tempest.api.image.v1.test_images.ListImagesTest.test_index_no_params                                                                     | 0.05174   | success |
 296   | tempest.api.image.v2.test_images.BasicOperationsImagesTest.test_delete_image                                                             | 0.29017   | success |
 297   | tempest.api.image.v2.test_images.BasicOperationsImagesTest.test_register_upload_get_image_file                                           | 0.42424   | success |
 298   | tempest.api.image.v2.test_images.BasicOperationsImagesTest.test_update_image                                                             | 0.68054   | success |
 299   | tempest.api.network.test_extensions.ExtensionsTestJSON.test_list_show_extensions                                                         | 0.47508   | success |
 300   | tempest.api.network.test_floating_ips.FloatingIPTestJSON.test_create_floating_ip_specifying_a_fixed_ip_address                           | 0.71112   | success |
 301   | tempest.api.network.test_floating_ips.FloatingIPTestJSON.test_create_list_show_update_delete_floating_ip                                 | 0.73746   | success |
 302   | tempest.api.network.test_networks.BulkNetworkOpsIpV6TestJSON.test_bulk_create_delete_network                                             | 0.67128   | success |
 303   | tempest.api.network.test_networks.BulkNetworkOpsIpV6TestJSON.test_bulk_create_delete_port                                                | 1.08614   | success |
 304   | tempest.api.network.test_networks.BulkNetworkOpsIpV6TestJSON.test_bulk_create_delete_subnet                                              | 3.40037   | success |
 305   | tempest.api.network.test_networks.BulkNetworkOpsTestJSON.test_bulk_create_delete_network                                                 | 0.58717   | success |
 306   | tempest.api.network.test_networks.BulkNetworkOpsTestJSON.test_bulk_create_delete_port                                                    | 1.30633   | success |
 307   | tempest.api.network.test_networks.BulkNetworkOpsTestJSON.test_bulk_create_delete_subnet                                                  | 1.63105   | success |
 308   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_create_update_delete_network_subnet                                         | 1.03824   | success |
 309   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_external_network_visibility                                                 | 0.20400   | success |
 310   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_list_networks                                                               | 0.08155   | success |
 311   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_list_subnets                                                                | 0.15349   | success |
 312   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_show_network                                                                | 0.02530   | success |
 313   | tempest.api.network.test_networks.NetworksIpV6TestAttrs.test_show_subnet                                                                 | 0.05855   | success |
 314   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_create_update_delete_network_subnet                                          | 1.25511   | success |
 315   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_external_network_visibility                                                  | 0.10543   | success |
 316   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_list_networks                                                                | 0.06155   | success |
 317   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_list_subnets                                                                 | 0.12005   | success |
 318   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_show_network                                                                 | 0.03140   | success |
 319   | tempest.api.network.test_networks.NetworksIpV6TestJSON.test_show_subnet                                                                  | 0.03071   | success |
 320   | tempest.api.network.test_ports.PortsIpV6TestJSON.test_create_port_in_allowed_allocation_pools                                            | 1.80504   | success |
 321   | tempest.api.network.test_ports.PortsIpV6TestJSON.test_create_port_with_no_securitygroups                                                 | 1.23140   | success |
 322   | tempest.api.network.test_ports.PortsIpV6TestJSON.test_create_update_delete_port                                                          | 0.78307   | success |
 323   | tempest.api.network.test_ports.PortsIpV6TestJSON.test_list_ports                                                                         | 0.04927   | success |
 324   | tempest.api.network.test_ports.PortsIpV6TestJSON.test_show_port                                                                          | 0.05300   | success |
 325   | tempest.api.network.test_ports.PortsTestJSON.test_create_port_in_allowed_allocation_pools                                                | 1.16549   | success |
 326   | tempest.api.network.test_ports.PortsTestJSON.test_create_port_with_no_securitygroups                                                     | 1.18066   | success |
 327   | tempest.api.network.test_ports.PortsTestJSON.test_create_update_delete_port                                                              | 0.77082   | success |
 328   | tempest.api.network.test_ports.PortsTestJSON.test_list_ports                                                                             | 0.06872   | success |
 329   | tempest.api.network.test_ports.PortsTestJSON.test_show_port                                                                              | 0.05677   | success |
 330   | tempest.api.network.test_routers.RoutersIpV6Test.test_add_multiple_router_interfaces                                                     | 2.80443   | success |
 331   | tempest.api.network.test_routers.RoutersIpV6Test.test_add_remove_router_interface_with_port_id                                           | 1.63531   | success |
 332   | tempest.api.network.test_routers.RoutersIpV6Test.test_add_remove_router_interface_with_subnet_id                                         | 1.35836   | success |
 333   | tempest.api.network.test_routers.RoutersIpV6Test.test_create_show_list_update_delete_router                                              | 1.03564   | success |
 334   | tempest.api.network.test_routers.RoutersTest.test_add_multiple_router_interfaces                                                         | 2.80813   | success |
 335   | tempest.api.network.test_routers.RoutersTest.test_add_remove_router_interface_with_port_id                                               | 1.34980   | success |
 336   | tempest.api.network.test_routers.RoutersTest.test_add_remove_router_interface_with_subnet_id                                             | 1.44477   | success |
 337   | tempest.api.network.test_routers.RoutersTest.test_create_show_list_update_delete_router                                                  | 0.84429   | success |
 338   | tempest.api.network.test_security_groups.SecGroupIPv6Test.test_create_list_update_show_delete_security_group                             | 0.43816   | success |
 339   | tempest.api.network.test_security_groups.SecGroupIPv6Test.test_create_show_delete_security_group_rule                                    | 0.56186   | success |
 340   | tempest.api.network.test_security_groups.SecGroupIPv6Test.test_list_security_groups                                                      | 0.02541   | success |
 341   | tempest.api.network.test_security_groups.SecGroupTest.test_create_list_update_show_delete_security_group                                 | 0.42898   | success |
 342   | tempest.api.network.test_security_groups.SecGroupTest.test_create_show_delete_security_group_rule                                        | 0.57004   | success |
 343   | tempest.api.network.test_security_groups.SecGroupTest.test_list_security_groups                                                          | 0.03255   | success |
 344   | tempest.api.orchestration.stacks.test_resource_types.ResourceTypesTest.test_resource_type_list                                           | 0.37517   | success |
 345   | tempest.api.orchestration.stacks.test_resource_types.ResourceTypesTest.test_resource_type_show                                           | 5.10610   | success |
 346   | tempest.api.orchestration.stacks.test_resource_types.ResourceTypesTest.test_resource_type_template                                       | 0.02256   | success |
 347   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_get_deployment_list                                              | 0.72815   | success |
 348   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_get_deployment_metadata                                          | 0.37456   | success |
 349   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_get_software_config                                              | 0.61271   | success |
 350   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_software_deployment_create_validate                              | 0.69521   | success |
 351   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_software_deployment_update_no_metadata_change                    | 0.68138   | success |
 352   | tempest.api.orchestration.stacks.test_soft_conf.TestSoftwareConfig.test_software_deployment_update_with_metadata_change                  | 0.39513   | success |
 353   | tempest.api.orchestration.stacks.test_stacks.StacksTestJSON.test_stack_crud_no_resources                                                 | 2.32413   | success |
 354   | tempest.api.orchestration.stacks.test_stacks.StacksTestJSON.test_stack_list_responds                                                     | 0.02259   | success |
 355   | tempest.api.telemetry.test_telemetry_notification_api.TelemetryNotificationAPITestJSON.test_check_glance_v1_notifications                | 0.75379   | success |
 356   | tempest.api.telemetry.test_telemetry_notification_api.TelemetryNotificationAPITestJSON.test_check_glance_v2_notifications                | 1.52753   | success |
 357   | tempest.api.volume.test_volumes_actions.VolumesV1ActionsTest.test_attach_detach_volume_to_instance                                       | 2.53395   | success |
 358   | tempest.api.volume.test_volumes_actions.VolumesV2ActionsTest.test_attach_detach_volume_to_instance                                       | 2.66529   | success |
 359   | tempest.api.volume.test_volumes_get.VolumesV1GetTest.test_volume_create_get_update_delete                                                | 11.60002  | success |
 360   | tempest.api.volume.test_volumes_get.VolumesV1GetTest.test_volume_create_get_update_delete_from_image                                     | 11.02724  | success |
 361   | tempest.api.volume.test_volumes_get.VolumesV2GetTest.test_volume_create_get_update_delete                                                | 10.53925  | success |
 362   | tempest.api.volume.test_volumes_get.VolumesV2GetTest.test_volume_create_get_update_delete_from_image                                     | 10.81895  | success |
 363   | tempest.api.volume.test_volumes_list.VolumesV1ListTestJSON.test_volume_list                                                              | 0.13870   | success |
 364   | tempest.api.volume.test_volumes_list.VolumesV2ListTestJSON.test_volume_list                                                              | 0.13807   | success |
 365   | tempest.scenario.test_network_basic_ops.TestNetworkBasicOps.test_network_basic_ops                                                       | 363.10201 | fail    |
 366   | tempest.scenario.test_server_basic_ops.TestServerBasicOps.test_server_basicops                                                           | 75.16093  | fail    |
 367   | tempest.scenario.test_volume_boot_pattern.TestVolumeBootPattern.test_volume_boot_pattern                                                 | 507.93579 | fail    |
 368   | tempest.scenario.test_volume_boot_pattern.TestVolumeBootPatternV2.test_volume_boot_pattern                                               | 507.54584 | fail    |
 369   +------------------------------------------------------------------------------------------------------------------------------------------+-----------+---------+
 370   2016-02-12 19:28:37,433 - run_tempest - DEBUG - Executing command : rally verify list
 371   2016-02-12 19:28:37,991 - run_tempest - INFO - Results: {'timestart': '2016-02-1219:10:30.775632', 'duration': 1086, 'tests': 210, 'failures': 11}
 372   2016-02-12 19:28:37,991 - run_tempest - DEBUG - Push result into DB
 373   2016-02-12 19:28:37,992 - run_tempest - INFO - Pushing results to DB: 'http://testresults.opnfv.org/testapi/results'.
 374   2016-02-12 19:28:38,675 - run_tempest - DEBUG - <Response [200]>
 375   2016-02-12 19:28:38,675 - run_tempest - INFO - Deleting tenant and user for Tempest suite)
 376   None
 377 ::
 378
 379 Running test case: onos
 380 -----------------------
 381
 382 ::
 383   FUNCTEST.info: Running ONOS test case...
 384   2016-02-12 19:28:41,069 - onos- DEBUG - Download Onos Teston codes https://github.com/sunyulin/OnosSystemTest.git
 385   Cloning into '/home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest'...
 386   2016-02-12 19:28:53,296 - onos- DEBUG - ONOS IP is 192.168.10.51
 387   2016-02-12 19:28:53,296 - onos- DEBUG - Run script FUNCvirNetNB
 388   2016-02-12 19:28:53,399 - FUNCvirNetNB - INFO - Creating component Handle: ONOSrest
 389
 390                                   +----------------+
 391   ------------------------------ { Script And Files }  ------------------------------
 392                                   +----------------+
 393
 394         Script Log File : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNB_12_Feb_2016_19_28_53/FUNCvirNetNB_12_Feb_2016_19_28_53.log
 395         Report Log File : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNB_12_Feb_2016_19_28_53/FUNCvirNetNB_12_Feb_2016_19_28_53.rpt
 396         ONOSrest Session Log : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNB_12_Feb_2016_19_28_53/ONOSrest.session
 397         Test Script :/home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNB.py
 398         Test Params : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNB.params
 399         Topology : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNB.topo
 400                                 +------------------+
 401   ---------------------------  { Script Exec Params }  ---------------------------
 402                                 +------------------+
 403
 404         'MININET':
 405         'switch': '7'
 406          'links': '20'
 407
 408          'GIT':
 409         'pull': 'False'
 410          'branch': 'master'
 411
 412          'HTTP':
 413         'path': '/onos/vtn/'
 414          'port': '8181'
 415
 416          'CTRL':
 417         'ip1': 'OC1'
 418          'port1': '6633'
 419
 420          'testcases': '2
 421         3
 422         4
 423         5
 424         6
 425         7
 426         8
 427         9
 428         10'
 429          'SLEEP':
 430         'startup': '15'
 431
 432          'ENV':
 433         'cellApps': 'drivers
 434         openflow
 435         proxyarp
 436         mobility'
 437          'cellName': 'singlenode'
 438
 439                                  +---------------+
 440   ----------------------------- { Components Used }  -----------------------------
 441                                  +---------------+
 442         ONOSrest
 443
 444                                 +--------+
 445   ---------------------------- { Topology }  ----------------------------
 446                                 +--------+
 447
 448         'ONOSrest':
 449         'connect_order': '4'
 450          'host': 'OC1'
 451          'user': 'root'
 452          'COMPONENTS': ''
 453          'password': 'r00tme'
 454          'type': 'OnosRestDriver'
 455
 456   ------------------------------------------------------------
 457
 458   ******************************
 459    CASE INIT
 460   ******************************
 461
 462   ['ONOSrest']
 463
 464   ******************************
 465    Result summary for Testcase2
 466   ******************************
 467
 468   [2016-02-12 19:28:53.480315] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Network Post
 469   [2016-02-12 19:28:53.480532] [FUNCvirNetNB] [STEP]  2.1: Generate Post Data
 470   [2016-02-12 19:28:53.480839] [FUNCvirNetNB] [STEP]  2.2: Post Data via HTTP
 471   [2016-02-12 19:28:53.673391] [FUNCvirNetNB] [STEP]  2.3: Get Data via HTTP
 472   [2016-02-12 19:28:53.681088] [FUNCvirNetNB] [STEP]  2.4: Compare Send Id and Get Id
 473
 474   *****************************
 475    Result: Pass
 476   *****************************
 477
 478   ******************************
 479    Result summary for Testcase3
 480   ******************************
 481
 482   [2016-02-12 19:28:53.688351] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Network Update
 483   [2016-02-12 19:28:53.688588] [FUNCvirNetNB] [STEP]  3.1: Generate Post Data
 484   [2016-02-12 19:28:53.688953] [FUNCvirNetNB] [STEP]  3.2: Post Data via HTTP
 485   [2016-02-12 19:28:53.695867] [FUNCvirNetNB] [STEP]  3.3: Update Data via HTTP
 486   [2016-02-12 19:28:53.704924] [FUNCvirNetNB] [STEP]  3.4: Get Data via HTTP
 487   [2016-02-12 19:28:53.709109] [FUNCvirNetNB] [STEP]  3.5: Compare Update data.
 488
 489   *****************************
 490    Result: Pass
 491   *****************************
 492
 493   ******************************
 494    Result summary for Testcase4
 495   ******************************
 496
 497   [2016-02-12 19:28:53.720293] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Network Delete
 498   [2016-02-12 19:28:53.720510] [FUNCvirNetNB] [STEP]  4.1: Generate Post Data
 499   [2016-02-12 19:28:53.720819] [FUNCvirNetNB] [STEP]  4.2: Post Data via HTTP
 500   [2016-02-12 19:28:53.726943] [FUNCvirNetNB] [STEP]  4.3: Delete Data via HTTP
 501   [2016-02-12 19:28:53.731614] [FUNCvirNetNB] [STEP]  4.4: Get Data is NULL
 502
 503   *****************************
 504    Result: Pass
 505   *****************************
 506
 507   ******************************
 508    Result summary for Testcase5
 509   ******************************
 510
 511   [2016-02-12 19:28:58.748088] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Subnet Post
 512   [2016-02-12 19:28:58.748345] [FUNCvirNetNB] [STEP]  5.1: Generate Post Data
 513   [2016-02-12 19:28:58.748742] [FUNCvirNetNB] [STEP]  5.2: Post Network Data via HTTP(Post Subnet need post network)
 514   [2016-02-12 19:28:58.760851] [FUNCvirNetNB] [STEP]  5.3: Post Subnet Data via HTTP
 515   [2016-02-12 19:28:58.797496] [FUNCvirNetNB] [STEP]  5.4: Get Subnet Data via HTTP
 516   [2016-02-12 19:28:58.806663] [FUNCvirNetNB] [STEP]  5.5: Compare Post Subnet Data via HTTP
 517
 518   *****************************
 519    Result: Pass
 520   *****************************
 521
 522   ******************************
 523    Result summary for Testcase6
 524   ******************************
 525
 526   [2016-02-12 19:28:58.813611] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Subnet Update
 527   [2016-02-12 19:28:58.813885] [FUNCvirNetNB] [STEP]  6.1: Generate Post Data
 528   [2016-02-12 19:28:58.814422] [FUNCvirNetNB] [STEP]  6.2: Post Network Data via HTTP(Post Subnet need post network)
 529   [2016-02-12 19:28:58.821242] [FUNCvirNetNB] [STEP]  6.3: Post Subnet Data via HTTP
 530   [2016-02-12 19:28:58.827664] [FUNCvirNetNB] [STEP]  6.4: Update Subnet Data via HTTP
 531   [2016-02-12 19:28:58.855303] [FUNCvirNetNB] [STEP]  6.5: Get Subnet Data via HTTP
 532   [2016-02-12 19:28:58.859648] [FUNCvirNetNB] [STEP]  6.6: Compare Subnet Data
 533   [2016-02-12 19:28:58.859965] [FUNCvirNetNB] [STEP]  6.7: Delete Subnet via HTTP
 534
 535   *****************************
 536    Result: Pass
 537   *****************************
 538
 539   ******************************
 540    Result summary for Testcase7
 541   ******************************
 542
 543   [2016-02-12 19:28:58.865645] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Subnet Delete
 544   [2016-02-12 19:28:58.865877] [FUNCvirNetNB] [STEP]  7.1: Generate Post Data
 545   [2016-02-12 19:28:58.866330] [FUNCvirNetNB] [STEP]  7.2: Post Network Data via HTTP(Post Subnet need post network)
 546   [2016-02-12 19:28:58.874618] [FUNCvirNetNB] [STEP]  7.3: Post Subnet Data via HTTP
 547   [2016-02-12 19:28:58.880254] [FUNCvirNetNB] [STEP]  7.4: Delete Subnet Data via HTTP
 548   [2016-02-12 19:28:58.884603] [FUNCvirNetNB] [STEP]  7.5: Get Subnet Data is NULL
 549
 550   *****************************
 551    Result: Pass
 552   *****************************
 553
 554   ******************************
 555    Result summary for Testcase8
 556   ******************************
 557
 558   [2016-02-12 19:29:03.902255] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Port Post
 559   [2016-02-12 19:29:03.902540] [FUNCvirNetNB] [STEP]  8.1: Generate Post Data
 560   [2016-02-12 19:29:03.903021] [FUNCvirNetNB] [STEP]  8.2: Post Network Data via HTTP(Post port need post network)
 561   [2016-02-12 19:29:03.914466] [FUNCvirNetNB] [STEP]  8.3: Post Subnet Data via HTTP(Post port need post subnet)
 562   [2016-02-12 19:29:03.923591] [FUNCvirNetNB] [STEP]  8.4: Post Port Data via HTTP
 563   [2016-02-12 19:29:03.949876] [FUNCvirNetNB] [STEP]  8.5: Get Port Data via HTTP
 564   [2016-02-12 19:29:03.957954] [FUNCvirNetNB] [STEP]  8.6: Compare Post Port Data
 565   [2016-02-12 19:29:03.958632] [FUNCvirNetNB] [STEP]  8.7: Clean Data via HTTP
 566
 567   *****************************
 568    Result: Pass
 569   *****************************
 570
 571   ******************************
 572    Result summary for Testcase9
 573   ******************************
 574
 575   [2016-02-12 19:29:03.964924] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Port Update
 576   [2016-02-12 19:29:03.965218] [FUNCvirNetNB] [STEP]  9.1: Generate Post Data
 577   [2016-02-12 19:29:03.965870] [FUNCvirNetNB] [STEP]  9.2: Post Network Data via HTTP(Post port need post network)
 578   [2016-02-12 19:29:03.971829] [FUNCvirNetNB] [STEP]  9.3: Post Subnet Data via HTTP(Post port need post subnet)
 579   [2016-02-12 19:29:03.978163] [FUNCvirNetNB] [STEP]  9.4: Post Port Data via HTTP
 580   [2016-02-12 19:29:03.983378] [FUNCvirNetNB] [STEP]  9.5: Update Port Data via HTTP
 581   [2016-02-12 19:29:03.989288] [FUNCvirNetNB] [STEP]  9.6: Get Port Data via HTTP
 582   [2016-02-12 19:29:03.993426] [FUNCvirNetNB] [STEP]  9.7: Compare Update Port Data
 583   [2016-02-12 19:29:03.993978] [FUNCvirNetNB] [STEP]  9.8: Clean Data via HTTP
 584
 585   *****************************
 586    Result: Pass
 587   *****************************
 588
 589   ******************************
 590    Result summary for Testcase10
 591   ******************************
 592
 593   [2016-02-12 19:29:04.000036] [FUNCvirNetNB] [CASE]  Virtual Network NBI Test - Port Delete
 594   [2016-02-12 19:29:04.000338] [FUNCvirNetNB] [STEP]  10.1: Generate Post Data
 595   [2016-02-12 19:29:04.000802] [FUNCvirNetNB] [STEP]  10.2: Post Network Data via HTTP(Post port need post network)
 596   [2016-02-12 19:29:04.005815] [FUNCvirNetNB] [STEP]  10.3: Post Subnet Data via HTTP(Post port need post subnet)
 597   [2016-02-12 19:29:04.011511] [FUNCvirNetNB] [STEP]  10.4: Post Port Data via HTTP
 598   [2016-02-12 19:29:04.016942] [FUNCvirNetNB] [STEP]  10.5: Delete Port Data via HTTP
 599   [2016-02-12 19:29:04.023147] [FUNCvirNetNB] [STEP]  10.6: Get Port Data is NULL
 600   [2016-02-12 19:29:09.043011] [FUNCvirNetNB] [STEP]  10.7: Clean Data via HTTP
 601
 602   *****************************
 603    Result: Pass
 604   *****************************
 605
 606   *************************************
 607         Test Execution Summary
 608
 609   *************************************
 610
 611    Test Start           : 12 Feb 2016 19:28:53
 612    Test End             : 12 Feb 2016 19:29:09
 613    Execution Time       : 0:00:15.653141
 614    Total tests planned  : 9
 615    Total tests RUN      : 9
 616    Total Pass           : 9
 617    Total Fail           : 0
 618    Total No Result      : 0
 619    Success Percentage   : 100%
 620    Execution Result     : 100%
 621   Disconnecting from ONOSrest: <drivers.common.api.controller.onosrestdriver.OnosRestDriver object at 0x7f055d67ea90>
 622   2016-02-12 19:29:09,098 - onos- DEBUG - Run script FUNCvirNetNBL3
 623   2016-02-12 19:29:09,185 - FUNCvirNetNBL3 - INFO - Creating component Handle: ONOSrest
 624
 625                                   +----------------+
 626   ------------------------------ { Script And Files }  ------------------------------
 627                                   +----------------+
 628
 629         Script Log File : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNBL3_12_Feb_2016_19_29_09/FUNCvirNetNBL3_12_Feb_2016_19_29_09.log
 630         Report Log File : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNBL3_12_Feb_2016_19_29_09/FUNCvirNetNBL3_12_Feb_2016_19_29_09.rpt
 631         ONOSrest Session Log : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/logs/FUNCvirNetNBL3_12_Feb_2016_19_29_09/ONOSrest.session
 632         Test Script :/home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNBL3.py
 633         Test Params : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNBL3.params
 634         Topology : /home/opnfv/repos/functest/testcases/Controllers/ONOS/Teston/CI/OnosSystemTest/TestON/Tests/FUNCvirNetNBL3.topo
 635                                 +------------------+
 636   ---------------------------  { Script Exec Params }  ---------------------------
 637                                 +------------------+
 638
 639         'MININET':
 640         'switch': '7'
 641          'links': '20'
 642
 643          'GIT':
 644         'pull': 'False'
 645          'branch': 'master'
 646
 647          'HTTP':
 648         'path': '/onos/vtn/'
 649          'port': '8181'
 650
 651          'CTRL':
 652         'ip1': 'OC1'
 653          'port1': '6653'
 654
 655          'testcases': '2
 656         3
 657         4
 658         5
 659         6
 660         7
 661         8
 662         9
 663         10
 664         11
 665         12'
 666          'SLEEP':
 667         'startup': '15'
 668
 669          'ENV':
 670         'cellApps': 'drivers
 671         openflow
 672         proxyarp
 673         mobility'
 674          'cellName': 'singlenode'
 675
 676                                  +---------------+
 677   ----------------------------- { Components Used }  -----------------------------
 678                                  +---------------+
 679         ONOSrest
 680
 681                                 +--------+
 682   ---------------------------- { Topology }  ----------------------------
 683                                 +--------+
 684
 685         'ONOSrest':
 686         'connect_order': '4'
 687          'host': 'OC1'
 688          'user': 'root'
 689          'COMPONENTS': ''
 690          'password': 'root'
 691          'type': 'OnosRestDriver'
 692
 693   ------------------------------------------------------------
 694
 695   ******************************
 696    CASE INIT
 697   ******************************
 698
 699   ['ONOSrest']
 700
 701   ******************************
 702    Result summary for Testcase2
 703   ******************************
 704
 705   [2016-02-12 19:29:09.253891] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Router Post
 706   [2016-02-12 19:29:09.254426] [FUNCvirNetNBL3] [STEP]  2.1: Post Network Data via HTTP(Post Router need post network)
 707   [2016-02-12 19:29:09.277464] [FUNCvirNetNBL3] [STEP]  2.2: Post Router Data via HTTP
 708   [2016-02-12 19:29:09.286749] [FUNCvirNetNBL3] [STEP]  2.3: Get Router Data via HTTP
 709   [2016-02-12 19:29:09.292011] [FUNCvirNetNBL3] [STEP]  2.4: Compare Post Router Data via HTTP
 710
 711   *****************************
 712    Result: Pass
 713   *****************************
 714
 715   ******************************
 716    Result summary for Testcase3
 717   ******************************
 718
 719   [2016-02-12 19:29:09.304490] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Router Update
 720   [2016-02-12 19:29:09.305193] [FUNCvirNetNBL3] [STEP]  3.1: Post Network Data via HTTP(Post Router need post network)
 721   [2016-02-12 19:29:09.310364] [FUNCvirNetNBL3] [STEP]  3.2: Post Router Data via HTTP
 722   [2016-02-12 19:29:09.314733] [FUNCvirNetNBL3] [STEP]  3.3: Update Router Data via HTTP
 723   [2016-02-12 19:29:09.318528] [FUNCvirNetNBL3] [STEP]  3.4: Get Router Data via HTTP
 724   [2016-02-12 19:29:09.321779] [FUNCvirNetNBL3] [STEP]  3.5: Compare Router Data
 725   [2016-02-12 19:29:09.322160] [FUNCvirNetNBL3] [STEP]  3.6: Delete Router via HTTP
 726
 727   *****************************
 728    Result: Pass
 729   *****************************
 730
 731   ******************************
 732    Result summary for Testcase4
 733   ******************************
 734
 735   [2016-02-12 19:29:09.326335] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Router Delete
 736   [2016-02-12 19:29:09.326694] [FUNCvirNetNBL3] [STEP]  4.1: Post Network Data via HTTP(Post Router need post network)
 737   [2016-02-12 19:29:09.331266] [FUNCvirNetNBL3] [STEP]  4.2: Post Router Data via HTTP
 738   [2016-02-12 19:29:09.334749] [FUNCvirNetNBL3] [STEP]  4.3: Delete Router Data via HTTP
 739   [2016-02-12 19:29:09.338576] [FUNCvirNetNBL3] [STEP]  4.4: Get Router Data is NULL
 740   Verify the Router status
 741
 742   *****************************
 743    Result: Pass
 744   *****************************
 745
 746   ******************************
 747    Result summary for Testcase5
 748   ******************************
 749
 750   [2016-02-12 19:29:14.353712] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - RouterInterface Post
 751   [2016-02-12 19:29:14.354333] [FUNCvirNetNBL3] [STEP]  5.1: Post Network Data via HTTP(Post port need post network)
 752   [2016-02-12 19:29:14.362760] [FUNCvirNetNBL3] [STEP]  5.2: Post Subnet Data via HTTP(Post port need post subnet)
 753   [2016-02-12 19:29:14.370550] [FUNCvirNetNBL3] [STEP]  5.3: Post Port Data via HTTP
 754   [2016-02-12 19:29:14.377722] [FUNCvirNetNBL3] [STEP]  5.4: Post Router Data via HTTP
 755   [2016-02-12 19:29:14.382048] [FUNCvirNetNBL3] [STEP]  5.5: Put RouterInterface Data via HTTP
 756   [2016-02-12 19:29:14.390960] [FUNCvirNetNBL3] [STEP]  5.6: Get RouterInterface Data via HTTP
 757   [2016-02-12 19:29:14.396121] [FUNCvirNetNBL3] [STEP]  5.7: Compare Post Port Data
 758   [2016-02-12 19:29:14.396706] [FUNCvirNetNBL3] [STEP]  5.8: Del RouterInterface Data via HTTP
 759   [2016-02-12 19:29:14.402504] [FUNCvirNetNBL3] [STEP]  5.9: Clean Data via HTTP
 760
 761   *****************************
 762    Result: Pass
 763   *****************************
 764
 765   ******************************
 766    Result summary for Testcase6
 767   ******************************
 768
 769   [2016-02-12 19:29:14.414994] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - RouterInterface Delete
 770   [2016-02-12 19:29:14.415949] [FUNCvirNetNBL3] [STEP]  6.1: Post Network Data via HTTP(Post port need post network)
 771   [2016-02-12 19:29:14.423498] [FUNCvirNetNBL3] [STEP]  6.2: Post Subnet Data via HTTP(Post port need post subnet)
 772   [2016-02-12 19:29:14.429906] [FUNCvirNetNBL3] [STEP]  6.3: Post Port Data via HTTP
 773   [2016-02-12 19:29:14.435831] [FUNCvirNetNBL3] [STEP]  6.4: Post Router Data via HTTP
 774   [2016-02-12 19:29:14.440530] [FUNCvirNetNBL3] [STEP]  6.5: Post RouterInterface Data via HTTP
 775   [2016-02-12 19:29:14.446879] [FUNCvirNetNBL3] [STEP]  6.6: Del RouterInterface Data via HTTP
 776   [2016-02-12 19:29:14.451643] [FUNCvirNetNBL3] [STEP]  6.7: Delete Port Data via HTTP
 777   [2016-02-12 19:29:14.456442] [FUNCvirNetNBL3] [STEP]  6.8: Get Port Data is NULL
 778   [2016-02-12 19:29:19.470955] [FUNCvirNetNBL3] [STEP]  6.9: Clean Data via HTTP
 779
 780   *****************************
 781    Result: Pass
 782   *****************************
 783
 784   ******************************
 785    Result summary for Testcase7
 786   ******************************
 787
 788   [2016-02-12 19:29:19.490054] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - FloatingIp Post
 789   [2016-02-12 19:29:19.491154] [FUNCvirNetNBL3] [STEP]  7.1: Post Network Data via HTTP(Post port need post network)
 790   [2016-02-12 19:29:19.498986] [FUNCvirNetNBL3] [STEP]  7.2: Post Subnet Data via HTTP(Post port need post subnet)
 791   [2016-02-12 19:29:19.506140] [FUNCvirNetNBL3] [STEP]  7.3: Post Port Data via HTTP
 792   [2016-02-12 19:29:19.513307] [FUNCvirNetNBL3] [STEP]  7.4: Post Router Data via HTTP
 793   [2016-02-12 19:29:19.518189] [FUNCvirNetNBL3] [STEP]  7.5: Get Port Data via HTTP
 794   [2016-02-12 19:29:19.524948] [FUNCvirNetNBL3] [STEP]  7.6: Post FloatingIp Data via HTTP
 795   [2016-02-12 19:29:19.533344] [FUNCvirNetNBL3] [STEP]  7.7: Get Port Data via HTTP
 796   [2016-02-12 19:29:19.539749] [FUNCvirNetNBL3] [STEP]  7.8: Get FloatingIp Data via HTTP
 797   [2016-02-12 19:29:19.545027] [FUNCvirNetNBL3] [STEP]  7.9: Get FloatingIp Data via HTTP
 798   [2016-02-12 19:29:19.549383] [FUNCvirNetNBL3] [STEP]  7.10: Compare Post FloatingIp Data
 799   [2016-02-12 19:29:19.549818] [FUNCvirNetNBL3] [STEP]  7.11: Post FloatingIp Clean Data via HTTP
 800   [2016-02-12 19:29:19.554862] [FUNCvirNetNBL3] [STEP]  7.12: Clean Data via HTTP
 801
 802   *****************************
 803    Result: Pass
 804   *****************************
 805
 806   ******************************
 807    Result summary for Testcase8
 808   ******************************
 809
 810   [2016-02-12 19:29:19.570354] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - FloatingIp Update
 811   [2016-02-12 19:29:19.571070] [FUNCvirNetNBL3] [STEP]  8.1: Post Network Data via HTTP(Post port need post network)
 812   [2016-02-12 19:29:19.576537] [FUNCvirNetNBL3] [STEP]  8.2: Post Subnet Data via HTTP(Post port need post subnet)
 813   [2016-02-12 19:29:19.581859] [FUNCvirNetNBL3] [STEP]  8.3: Post Port Data via HTTP
 814   [2016-02-12 19:29:19.586976] [FUNCvirNetNBL3] [STEP]  8.4: Post Router Data via HTTP
 815   [2016-02-12 19:29:19.590621] [FUNCvirNetNBL3] [STEP]  8.5: Post FloatingIp Data via HTTP
 816   [2016-02-12 19:29:19.594786] [FUNCvirNetNBL3] [STEP]  8.6: Post Delete Data via HTTP
 817   [2016-02-12 19:29:19.598961] [FUNCvirNetNBL3] [STEP]  8.7: Post NewPort Data via HTTP
 818   [2016-02-12 19:29:19.604343] [FUNCvirNetNBL3] [STEP]  8.8: Post NewFloatingIp Data via HTTP
 819   [2016-02-12 19:29:19.608924] [FUNCvirNetNBL3] [STEP]  8.9: Get NewFloatingIp Data via HTTP
 820   [2016-02-12 19:29:19.612110] [FUNCvirNetNBL3] [STEP]  8.10: Compare Post FloatingIp Data
 821   [2016-02-12 19:29:19.612553] [FUNCvirNetNBL3] [STEP]  8.11: Post FloatingIp Clean Data via HTTP
 822   [2016-02-12 19:29:19.616988] [FUNCvirNetNBL3] [STEP]  8.12: Clean Data via HTTP
 823
 824   *****************************
 825    Result: Pass
 826   *****************************
 827
 828   ******************************
 829    Result summary for Testcase9
 830   ******************************
 831
 832   [2016-02-12 19:29:19.628499] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - FloatingIp Delete
 833   [2016-02-12 19:29:19.629101] [FUNCvirNetNBL3] [STEP]  9.1: Post Network Data via HTTP(Post port need post network)
 834   [2016-02-12 19:29:19.633446] [FUNCvirNetNBL3] [STEP]  9.2: Post Subnet Data via HTTP(Post port need post subnet)
 835   [2016-02-12 19:29:19.639341] [FUNCvirNetNBL3] [STEP]  9.3: Post Port Data via HTTP
 836   [2016-02-12 19:29:19.644221] [FUNCvirNetNBL3] [STEP]  9.4: Post Router Data via HTTP
 837   [2016-02-12 19:29:19.647812] [FUNCvirNetNBL3] [STEP]  9.5: Post FloatingIp Data via HTTP
 838   [2016-02-12 19:29:19.652083] [FUNCvirNetNBL3] [STEP]  9.6: Post FloatingIp Clean Data via HTTP
 839   [2016-02-12 19:29:19.658294] [FUNCvirNetNBL3] [STEP]  9.7: Get FloatingIp Data is NULL
 840   [2016-02-12 19:29:24.671790] [FUNCvirNetNBL3] [STEP]  9.8: Clean Data via HTTP
 841
 842   *****************************
 843    Result: Pass
 844   *****************************
 845
 846   ******************************
 847    Result summary for Testcase10
 848   ******************************
 849
 850   [2016-02-12 19:29:24.687368] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Gateway Post
 851   [2016-02-12 19:29:24.687942] [FUNCvirNetNBL3] [STEP]  10.1: Post Network Data via HTTP(Post port need post network)
 852   [2016-02-12 19:29:24.694589] [FUNCvirNetNBL3] [STEP]  10.2: Post Subnet Data via HTTP(Post port need post subnet)
 853   [2016-02-12 19:29:24.702207] [FUNCvirNetNBL3] [STEP]  10.3: Post Port Data via HTTP
 854   [2016-02-12 19:29:24.708359] [FUNCvirNetNBL3] [STEP]  10.4: Post Router Data via HTTP
 855   [2016-02-12 19:29:24.714159] [FUNCvirNetNBL3] [STEP]  10.5: Get Gateway Data via HTTP
 856   [2016-02-12 19:29:24.719097] [FUNCvirNetNBL3] [STEP]  10.6: Compare Post Gateway Data
 857   [2016-02-12 19:29:24.719529] [FUNCvirNetNBL3] [STEP]  10.7: Clean Data via HTTP
 858
 859   *****************************
 860    Result: Pass
 861   *****************************
 862
 863   ******************************
 864    Result summary for Testcase11
 865   ******************************
 866
 867   [2016-02-12 19:29:24.729627] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Gateway Update
 868   [2016-02-12 19:29:24.730471] [FUNCvirNetNBL3] [STEP]  11.1: Post Network Data via HTTP(Post port need post network)
 869   [2016-02-12 19:29:24.735199] [FUNCvirNetNBL3] [STEP]  11.2: Post Subnet Data via HTTP(Post port need post subnet)
 870   [2016-02-12 19:29:24.740390] [FUNCvirNetNBL3] [STEP]  11.3: Post Port Data via HTTP
 871   [2016-02-12 19:29:24.744907] [FUNCvirNetNBL3] [STEP]  11.4: Post Router Data via HTTP
 872   [2016-02-12 19:29:24.748738] [FUNCvirNetNBL3] [STEP]  11.5: Post New Router Data via HTTP
 873   [2016-02-12 19:29:24.753672] [FUNCvirNetNBL3] [STEP]  11.6: Get Gateway Data via HTTP
 874   [2016-02-12 19:29:24.756529] [FUNCvirNetNBL3] [STEP]  11.7: Compare Post Gateway Data
 875   [2016-02-12 19:29:24.756959] [FUNCvirNetNBL3] [STEP]  11.8: Clean Data via HTTP
 876
 877   *****************************
 878    Result: Pass
 879   *****************************
 880
 881   ******************************
 882    Result summary for Testcase12
 883   ******************************
 884
 885   [2016-02-12 19:29:24.765973] [FUNCvirNetNBL3] [CASE]  Virtual Network NBI Test - Gateway Delete
 886   [2016-02-12 19:29:24.766668] [FUNCvirNetNBL3] [STEP]  12.1: Post Network Data via HTTP(Post port need post network)
 887   [2016-02-12 19:29:24.771315] [FUNCvirNetNBL3] [STEP]  12.2: Post Subnet Data via HTTP(Post port need post subnet)
 888   [2016-02-12 19:29:24.776222] [FUNCvirNetNBL3] [STEP]  12.3: Post Port Data via HTTP
 889   [2016-02-12 19:29:24.781123] [FUNCvirNetNBL3] [STEP]  12.4: Post Router Data via HTTP
 890   [2016-02-12 19:29:24.787724] [FUNCvirNetNBL3] [STEP]  12.5: Post Del Gateway Data via HTTP
 891   [2016-02-12 19:29:24.791889] [FUNCvirNetNBL3] [STEP]  12.6: Get Gateway Data via HTTP
 892   [2016-02-12 19:29:24.794703] [FUNCvirNetNBL3] [STEP]  12.7: If Gateway Data is NULL
 893   [2016-02-12 19:29:29.800513] [FUNCvirNetNBL3] [STEP]  12.8: Clean Data via HTTP
 894
 895   *****************************
 896    Result: Pass
 897   *****************************
 898
 899   *************************************
 900         Test Execution Summary
 901
 902   *************************************
 903
 904    Test Start           : 12 Feb 2016 19:29:09
 905    Test End             : 12 Feb 2016 19:29:29
 906    Execution Time       : 0:00:20.634178
 907    Total tests planned  : 11
 908    Total tests RUN      : 11
 909    Total Pass           : 11
 910    Total Fail           : 0
 911    Total No Result      : 0
 912    Success Percentage   : 100%
 913    Execution Result     : 100%
 914   Disconnecting from ONOSrest: <drivers.common.api.controller.onosrestdriver.OnosRestDriver object at 0x7f4d848b7b10>
 915   2016-02-12 19:29:29,836 - onos- DEBUG - Push result into DB
 916   2016-02-12 19:29:31,842 - onos- DEBUG - Testcases Success
 917   2016-02-12 19:29:32,716 - onos- DEBUG - <Response [200]>
 918   2016-02-12 19:29:34,774 - onos- DEBUG - Clean ONOS Teston
 919 ::
 920
 921 Running test case: rally
 922 ------------------------
 923
 924 ::
 925   FUNCTEST.info: Running Rally benchmark suite...
 926   2016-02-12 19:29:35,590 - run_rally - DEBUG - Volume type 'volume_test' created succesfully...
 927   2016-02-12 19:29:35,715 - run_rally - DEBUG - Creating image 'functest-img' from '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img'...
 928   2016-02-12 19:29:36,257 - run_rally - DEBUG - Image 'functest-img' with ID '0c74bd9e-0ac2-4332-8e03-e00c266752ad' created succesfully .
 929   2016-02-12 19:29:36,257 - run_rally - INFO - Starting test scenario "authenticate" ...
 930   2016-02-12 19:29:36,257 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-authenticate.yaml
 931   2016-02-12 19:29:36,561 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['authenticate'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
 932   2016-02-12 19:30:03,978 - run_rally - INFO -
 933    Preparing input task
 934    Task  12233c47-6a06-4a69-9fda-761eae3e8dbd: started
 935   Task 12233c47-6a06-4a69-9fda-761eae3e8dbd: finished
 936
 937   test scenario Authenticate.validate_glance
 938   +-------------------------------------------------------------------------------------------------------+
 939   |                                         Response Times (sec)                                          |
 940   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 941   | action                           | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
 942   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 943   | authenticate.validate_glance     | 0.119 | 0.14   | 0.174  | 0.193  | 0.213 | 0.148 | 100.0%  | 10    |
 944   | authenticate.validate_glance (2) | 0.038 | 0.043  | 0.049  | 0.05   | 0.052 | 0.044 | 100.0%  | 10    |
 945   | total                            | 0.239 | 0.27   | 0.287  | 0.324  | 0.36  | 0.273 | 100.0%  | 10    |
 946   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 947   Load duration: 0.824501037598
 948   Full duration: 3.16589784622
 949
 950   test scenario Authenticate.keystone
 951   +-----------------------------------------------------------------------------+
 952   |                            Response Times (sec)                             |
 953   +--------+-------+--------+--------+--------+-------+-------+---------+-------+
 954   | action | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
 955   +--------+-------+--------+--------+--------+-------+-------+---------+-------+
 956   | total  | 0.065 | 0.075  | 0.13   | 0.137  | 0.144 | 0.085 | 100.0%  | 10    |
 957   +--------+-------+--------+--------+--------+-------+-------+---------+-------+
 958   Load duration: 0.295313119888
 959   Full duration: 2.90179300308
 960
 961   test scenario Authenticate.validate_heat
 962   +-----------------------------------------------------------------------------------------------------+
 963   |                                        Response Times (sec)                                         |
 964   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 965   | action                         | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
 966   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 967   | authenticate.validate_heat     | 0.11  | 0.135  | 0.274  | 0.305  | 0.336 | 0.165 | 100.0%  | 10    |
 968   | authenticate.validate_heat (2) | 0.022 | 0.036  | 0.112  | 0.26   | 0.407 | 0.081 | 100.0%  | 10    |
 969   | total                          | 0.212 | 0.258  | 0.484  | 0.567  | 0.649 | 0.324 | 100.0%  | 10    |
 970   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 971   Load duration: 1.13559103012
 972   Full duration: 3.52405309677
 973
 974   test scenario Authenticate.validate_nova
 975   +-----------------------------------------------------------------------------------------------------+
 976   |                                        Response Times (sec)                                         |
 977   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 978   | action                         | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
 979   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 980   | authenticate.validate_nova     | 0.104 | 0.133  | 0.155  | 0.159  | 0.163 | 0.134 | 100.0%  | 10    |
 981   | authenticate.validate_nova (2) | 0.023 | 0.043  | 0.054  | 0.057  | 0.06  | 0.041 | 100.0%  | 10    |
 982   | total                          | 0.212 | 0.264  | 0.271  | 0.273  | 0.275 | 0.251 | 100.0%  | 10    |
 983   +--------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 984   Load duration: 0.771644115448
 985   Full duration: 3.15462398529
 986
 987   test scenario Authenticate.validate_cinder
 988   +-------------------------------------------------------------------------------------------------------+
 989   |                                         Response Times (sec)                                          |
 990   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 991   | action                           | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
 992   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 993   | authenticate.validate_cinder     | 0.09  | 0.112  | 0.167  | 0.19   | 0.214 | 0.125 | 100.0%  | 10    |
 994   | authenticate.validate_cinder (2) | 0.013 | 0.096  | 0.137  | 0.264  | 0.391 | 0.107 | 100.0%  | 10    |
 995   | total                            | 0.188 | 0.296  | 0.465  | 0.536  | 0.606 | 0.321 | 100.0%  | 10    |
 996   +----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
 997   Load duration: 0.861793994904
 998   Full duration: 3.20478820801
 999
1000   test scenario Authenticate.validate_neutron
1001   +--------------------------------------------------------------------------------------------------------+
1002   |                                          Response Times (sec)                                          |
1003   +-----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1004   | action                            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1005   +-----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1006   | authenticate.validate_neutron     | 0.118 | 0.147  | 0.172  | 0.173  | 0.174 | 0.146 | 100.0%  | 10    |
1007   | authenticate.validate_neutron (2) | 0.03  | 0.081  | 0.091  | 0.104  | 0.118 | 0.07  | 100.0%  | 10    |
1008   | total                             | 0.278 | 0.313  | 0.37   | 0.392  | 0.414 | 0.32  | 100.0%  | 10    |
1009   +-----------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1010   Load duration: 0.945325136185
1011   Full duration: 3.43176603317
1012
1013   2016-02-12 19:30:03,978 - run_rally - DEBUG - task_id : 12233c47-6a06-4a69-9fda-761eae3e8dbd
1014   2016-02-12 19:30:03,978 - run_rally - DEBUG - running command line : rally task report 12233c47-6a06-4a69-9fda-761eae3e8dbd --out /home/opnfv/functest/results/rally/opnfv-authenticate.html
1015   2016-02-12 19:30:04,619 - run_rally - DEBUG - running command line : rally task results 12233c47-6a06-4a69-9fda-761eae3e8dbd
1016   2016-02-12 19:30:05,200 - run_rally - DEBUG - saving json file
1017   2016-02-12 19:30:05,202 - run_rally - DEBUG - Push result into DB
1018   2016-02-12 19:30:06,227 - run_rally - DEBUG - <Response [200]>
1019   2016-02-12 19:30:06,229 - run_rally - INFO - Test scenario: "authenticate" OK.
1020
1021   2016-02-12 19:30:06,229 - run_rally - INFO - Starting test scenario "glance" ...
1022   2016-02-12 19:30:06,229 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-glance.yaml
1023   2016-02-12 19:30:06,294 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['glance'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1024   2016-02-12 19:31:37,895 - run_rally - INFO -
1025    Preparing input task
1026    Task  a6ff81f3-d30b-42ca-afc7-a782a1b0ab87: started
1027   Task a6ff81f3-d30b-42ca-afc7-a782a1b0ab87: finished
1028
1029   test scenario GlanceImages.list_images
1030   +-----------------------------------------------------------------------------------------+
1031   |                                  Response Times (sec)                                   |
1032   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1033   | action             | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1034   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1035   | glance.list_images | 0.194 | 0.227  | 0.287  | 0.298  | 0.308 | 0.233 | 100.0%  | 10    |
1036   | total              | 0.194 | 0.228  | 0.288  | 0.298  | 0.308 | 0.233 | 100.0%  | 10    |
1037   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1038   Load duration: 0.686240911484
1039   Full duration: 3.71551012993
1040
1041   test scenario GlanceImages.create_image_and_boot_instances
1042   +-------------------------------------------------------------------------------------------+
1043   |                                   Response Times (sec)                                    |
1044   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1045   | action              | min   | median | 90%ile | 95%ile | max    | avg   | success | count |
1046   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1047   | glance.create_image | 2.802 | 2.97   | 3.613  | 3.651  | 3.689  | 3.103 | 100.0%  | 10    |
1048   | nova.boot_servers   | 4.931 | 6.467  | 7.729  | 7.951  | 8.172  | 6.422 | 100.0%  | 10    |
1049   | total               | 7.743 | 9.551  | 10.989 | 11.078 | 11.167 | 9.526 | 100.0%  | 10    |
1050   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1051   Load duration: 27.7058939934
1052   Full duration: 54.5110180378
1053
1054   test scenario GlanceImages.create_and_list_image
1055   +------------------------------------------------------------------------------------------+
1056   |                                   Response Times (sec)                                   |
1057   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1058   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1059   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1060   | glance.create_image | 2.794 | 2.942  | 3.667  | 3.74   | 3.813 | 3.135 | 100.0%  | 10    |
1061   | glance.list_images  | 0.037 | 0.047  | 0.052  | 0.054  | 0.057 | 0.047 | 100.0%  | 10    |
1062   | total               | 2.839 | 2.987  | 3.705  | 3.783  | 3.86  | 3.182 | 100.0%  | 10    |
1063   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1064   Load duration: 9.32158112526
1065   Full duration: 13.9724760056
1066
1067   test scenario GlanceImages.create_and_delete_image
1068   +------------------------------------------------------------------------------------------+
1069   |                                   Response Times (sec)                                   |
1070   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1071   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1072   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1073   | glance.create_image | 3.063 | 3.609  | 3.646  | 3.66   | 3.674 | 3.494 | 100.0%  | 10    |
1074   | glance.delete_image | 0.133 | 0.147  | 0.157  | 0.159  | 0.161 | 0.147 | 100.0%  | 10    |
1075   | total               | 3.211 | 3.766  | 3.799  | 3.807  | 3.815 | 3.641 | 100.0%  | 10    |
1076   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1077   Load duration: 10.6368820667
1078   Full duration: 13.9659121037
1079
1080   2016-02-12 19:31:37,895 - run_rally - DEBUG - task_id : a6ff81f3-d30b-42ca-afc7-a782a1b0ab87
1081   2016-02-12 19:31:37,895 - run_rally - DEBUG - running command line : rally task report a6ff81f3-d30b-42ca-afc7-a782a1b0ab87 --out /home/opnfv/functest/results/rally/opnfv-glance.html
1082   2016-02-12 19:31:38,502 - run_rally - DEBUG - running command line : rally task results a6ff81f3-d30b-42ca-afc7-a782a1b0ab87
1083   2016-02-12 19:31:39,084 - run_rally - DEBUG - saving json file
1084   2016-02-12 19:31:39,086 - run_rally - DEBUG - Push result into DB
1085   2016-02-12 19:31:39,820 - run_rally - DEBUG - <Response [200]>
1086   2016-02-12 19:31:39,821 - run_rally - INFO - Test scenario: "glance" OK.
1087
1088   2016-02-12 19:31:39,821 - run_rally - INFO - Starting test scenario "cinder" ...
1089   2016-02-12 19:31:39,821 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-cinder.yaml
1090   2016-02-12 19:31:40,044 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['cinder'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1091   2016-02-12 19:48:49,804 - run_rally - INFO -
1092    Preparing input task
1093    Task  a9edf9cf-40a7-49be-8eb6-a24ec3b12338: started
1094   Task a9edf9cf-40a7-49be-8eb6-a24ec3b12338: finished
1095
1096   test scenario CinderVolumes.create_and_attach_volume
1097   +----------------------------------------------------------------------------------------------+
1098   |                                     Response Times (sec)                                     |
1099   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1100   | action               | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1101   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1102   | nova.boot_server     | 3.002  | 4.449  | 6.528  | 6.555  | 6.583  | 4.869  | 100.0%  | 10    |
1103   | cinder.create_volume | 2.706  | 2.801  | 3.066  | 3.158  | 3.25   | 2.858  | 100.0%  | 10    |
1104   | nova.attach_volume   | 5.722  | 7.845  | 8.271  | 9.318  | 10.365 | 7.896  | 100.0%  | 10    |
1105   | nova.detach_volume   | 2.981  | 5.17   | 5.585  | 5.667  | 5.75   | 4.488  | 100.0%  | 10    |
1106   | cinder.delete_volume | 2.34   | 2.572  | 2.711  | 2.76   | 2.81   | 2.557  | 100.0%  | 10    |
1107   | nova.delete_server   | 2.392  | 2.47   | 2.55   | 2.552  | 2.553  | 2.468  | 100.0%  | 10    |
1108   | total                | 22.934 | 25.388 | 26.924 | 27.647 | 28.37  | 25.135 | 100.0%  | 10    |
1109   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1110   Load duration: 75.2977118492
1111   Full duration: 89.5739550591
1112
1113   test scenario CinderVolumes.create_and_list_volume
1114   +-------------------------------------------------------------------------------------------+
1115   |                                   Response Times (sec)                                    |
1116   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1117   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1118   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1119   | cinder.create_volume | 5.219 | 5.39   | 5.468  | 5.482  | 5.496 | 5.379 | 100.0%  | 10    |
1120   | cinder.list_volumes  | 0.103 | 0.12   | 0.172  | 0.211  | 0.25  | 0.136 | 100.0%  | 10    |
1121   | total                | 5.342 | 5.503  | 5.6    | 5.606  | 5.612 | 5.516 | 100.0%  | 10    |
1122   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1123   Load duration: 16.5520820618
1124   Full duration: 28.6927659512
1125
1126   test scenario CinderVolumes.create_and_list_volume
1127   +-------------------------------------------------------------------------------------------+
1128   |                                   Response Times (sec)                                    |
1129   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1130   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1131   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1132   | cinder.create_volume | 2.716 | 2.921  | 2.992  | 3.007  | 3.021 | 2.913 | 100.0%  | 10    |
1133   | cinder.list_volumes  | 0.056 | 0.122  | 0.156  | 0.193  | 0.23  | 0.124 | 100.0%  | 10    |
1134   | total                | 2.779 | 3.079  | 3.147  | 3.149  | 3.151 | 3.037 | 100.0%  | 10    |
1135   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1136   Load duration: 9.16054606438
1137   Full duration: 20.3591618538
1138
1139   test scenario CinderVolumes.create_and_list_snapshots
1140   +---------------------------------------------------------------------------------------------+
1141   |                                    Response Times (sec)                                     |
1142   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1143   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1144   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1145   | cinder.create_snapshot | 2.345 | 2.529  | 2.599  | 2.602  | 2.604 | 2.5   | 100.0%  | 10    |
1146   | cinder.list_snapshots  | 0.019 | 0.087  | 0.111  | 0.152  | 0.194 | 0.092 | 100.0%  | 10    |
1147   | total                  | 2.428 | 2.602  | 2.703  | 2.717  | 2.73  | 2.592 | 100.0%  | 10    |
1148   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1149   Load duration: 7.66090703011
1150   Full duration: 31.241134882
1151
1152   test scenario CinderVolumes.create_and_delete_volume
1153   +-------------------------------------------------------------------------------------------+
1154   |                                   Response Times (sec)                                    |
1155   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1156   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1157   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1158   | cinder.create_volume | 2.859 | 2.963  | 3.097  | 3.119  | 3.141 | 2.987 | 100.0%  | 10    |
1159   | cinder.delete_volume | 2.479 | 2.572  | 2.647  | 2.692  | 2.737 | 2.571 | 100.0%  | 10    |
1160   | total                | 5.459 | 5.542  | 5.642  | 5.653  | 5.664 | 5.558 | 100.0%  | 10    |
1161   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1162   Load duration: 16.6256108284
1163   Full duration: 23.5103900433
1164
1165   test scenario CinderVolumes.create_and_delete_volume
1166   +-------------------------------------------------------------------------------------------+
1167   |                                   Response Times (sec)                                    |
1168   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1169   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1170   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1171   | cinder.create_volume | 2.963 | 5.375  | 5.534  | 5.577  | 5.62  | 4.921 | 100.0%  | 10    |
1172   | cinder.delete_volume | 2.46  | 2.531  | 2.574  | 2.579  | 2.585 | 2.53  | 100.0%  | 10    |
1173   | total                | 5.535 | 7.886  | 8.07   | 8.075  | 8.08  | 7.452 | 100.0%  | 10    |
1174   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1175   Load duration: 21.419508934
1176   Full duration: 28.6083099842
1177
1178   test scenario CinderVolumes.create_and_delete_volume
1179   +-------------------------------------------------------------------------------------------+
1180   |                                   Response Times (sec)                                    |
1181   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1182   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1183   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1184   | cinder.create_volume | 2.847 | 3.004  | 3.162  | 3.163  | 3.164 | 2.998 | 100.0%  | 10    |
1185   | cinder.delete_volume | 2.468 | 2.621  | 2.777  | 2.815  | 2.854 | 2.642 | 100.0%  | 10    |
1186   | total                | 5.424 | 5.595  | 5.871  | 5.944  | 6.018 | 5.641 | 100.0%  | 10    |
1187   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1188   Load duration: 17.0380129814
1189   Full duration: 24.2403891087
1190
1191   test scenario CinderVolumes.create_and_upload_volume_to_image
1192   +-------------------------------------------------------------------------------------------------------+
1193   |                                         Response Times (sec)                                          |
1194   +-------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1195   | action                        | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1196   +-------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1197   | cinder.create_volume          | 2.866  | 2.999  | 3.171  | 3.29   | 3.408  | 3.018  | 100.0%  | 10    |
1198   | cinder.upload_volume_to_image | 23.67  | 57.563 | 78.789 | 79.793 | 80.797 | 56.738 | 100.0%  | 10    |
1199   | cinder.delete_volume          | 2.349  | 2.495  | 2.622  | 2.633  | 2.644  | 2.499  | 100.0%  | 10    |
1200   | nova.delete_image             | 0.312  | 0.391  | 0.562  | 0.637  | 0.713  | 0.426  | 100.0%  | 10    |
1201   | total                         | 29.568 | 63.477 | 84.729 | 85.718 | 86.707 | 62.682 | 100.0%  | 10    |
1202   +-------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1203   Load duration: 177.551611185
1204   Full duration: 185.510534048
1205
1206   test scenario CinderVolumes.create_and_delete_snapshot
1207   +---------------------------------------------------------------------------------------------+
1208   |                                    Response Times (sec)                                     |
1209   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1210   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1211   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1212   | cinder.create_snapshot | 2.439 | 2.557  | 2.66   | 2.678  | 2.696 | 2.563 | 100.0%  | 10    |
1213   | cinder.delete_snapshot | 2.272 | 2.36   | 2.526  | 2.557  | 2.588 | 2.387 | 100.0%  | 10    |
1214   | total                  | 4.799 | 4.98   | 5.034  | 5.066  | 5.098 | 4.95  | 100.0%  | 10    |
1215   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1216   Load duration: 14.8108210564
1217   Full duration: 34.6716730595
1218
1219   test scenario CinderVolumes.create_volume
1220   +------------------------------------------------------------------------------------------+
1221   |                                   Response Times (sec)                                   |
1222   +----------------------+-------+--------+--------+--------+------+-------+---------+-------+
1223   | action               | min   | median | 90%ile | 95%ile | max  | avg   | success | count |
1224   +----------------------+-------+--------+--------+--------+------+-------+---------+-------+
1225   | cinder.create_volume | 2.772 | 2.879  | 2.953  | 2.997  | 3.04 | 2.879 | 100.0%  | 10    |
1226   | total                | 2.772 | 2.879  | 2.953  | 2.997  | 3.04 | 2.879 | 100.0%  | 10    |
1227   +----------------------+-------+--------+--------+--------+------+-------+---------+-------+
1228   Load duration: 8.63443613052
1229   Full duration: 19.1983139515
1230
1231   test scenario CinderVolumes.create_volume
1232   +-------------------------------------------------------------------------------------------+
1233   |                                   Response Times (sec)                                    |
1234   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1235   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1236   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1237   | cinder.create_volume | 2.791 | 3.074  | 3.225  | 3.318  | 3.411 | 3.066 | 100.0%  | 10    |
1238   | total                | 2.791 | 3.074  | 3.225  | 3.318  | 3.411 | 3.066 | 100.0%  | 10    |
1239   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1240   Load duration: 9.021474123
1241   Full duration: 21.064909935
1242
1243   test scenario CinderVolumes.list_volumes
1244   +------------------------------------------------------------------------------------------+
1245   |                                   Response Times (sec)                                   |
1246   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1247   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1248   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1249   | cinder.list_volumes | 0.238 | 0.261  | 0.299  | 0.329  | 0.359 | 0.269 | 100.0%  | 10    |
1250   | total               | 0.238 | 0.261  | 0.299  | 0.329  | 0.359 | 0.27  | 100.0%  | 10    |
1251   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1252   Load duration: 0.793784856796
1253   Full duration: 48.040571928
1254
1255   test scenario CinderVolumes.create_nested_snapshots_and_attach_volume
1256   +-----------------------------------------------------------------------------------------------+
1257   |                                     Response Times (sec)                                      |
1258   +------------------------+--------+--------+--------+--------+--------+-------+---------+-------+
1259   | action                 | min    | median | 90%ile | 95%ile | max    | avg   | success | count |
1260   +------------------------+--------+--------+--------+--------+--------+-------+---------+-------+
1261   | cinder.create_volume   | 2.854  | 3.038  | 3.084  | 3.107  | 3.129  | 3.016 | 100.0%  | 10    |
1262   | cinder.create_snapshot | 2.308  | 2.414  | 2.44   | 2.444  | 2.449  | 2.402 | 100.0%  | 10    |
1263   | nova.attach_volume     | 7.678  | 7.886  | 12.033 | 12.294 | 12.555 | 8.94  | 100.0%  | 10    |
1264   | nova.detach_volume     | 3.108  | 4.554  | 5.993  | 6.787  | 7.581  | 4.673 | 100.0%  | 10    |
1265   | cinder.delete_snapshot | 2.213  | 2.342  | 2.485  | 2.5    | 2.514  | 2.362 | 100.0%  | 10    |
1266   | cinder.delete_volume   | 2.346  | 2.506  | 2.582  | 2.646  | 2.711  | 2.513 | 100.0%  | 10    |
1267   | total                  | 21.386 | 23.562 | 28.488 | 28.571 | 28.655 | 24.21 | 100.0%  | 10    |
1268   +------------------------+--------+--------+--------+--------+--------+-------+---------+-------+
1269   Load duration: 70.4934530258
1270   Full duration: 114.824916124
1271
1272   test scenario CinderVolumes.create_from_volume_and_delete_volume
1273   +----------------------------------------------------------------------------------------------+
1274   |                                     Response Times (sec)                                     |
1275   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1276   | action               | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1277   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1278   | cinder.create_volume | 7.69   | 13.562 | 19.985 | 21.954 | 23.923 | 14.049 | 100.0%  | 10    |
1279   | cinder.delete_volume | 2.371  | 2.493  | 2.866  | 3.881  | 4.895  | 2.733  | 100.0%  | 10    |
1280   | total                | 10.109 | 15.989 | 22.556 | 24.512 | 26.469 | 16.782 | 100.0%  | 10    |
1281   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1282   Load duration: 48.6095311642
1283   Full duration: 68.2930941582
1284
1285   test scenario CinderVolumes.create_and_extend_volume
1286   +-------------------------------------------------------------------------------------------+
1287   |                                   Response Times (sec)                                    |
1288   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1289   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1290   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1291   | cinder.create_volume | 2.789 | 2.985  | 3.108  | 3.14   | 3.172 | 2.99  | 100.0%  | 10    |
1292   | cinder.extend_volume | 2.644 | 2.745  | 2.831  | 2.838  | 2.845 | 2.753 | 100.0%  | 10    |
1293   | cinder.delete_volume | 2.484 | 2.576  | 2.624  | 2.627  | 2.63  | 2.566 | 100.0%  | 10    |
1294   | total                | 8.091 | 8.294  | 8.471  | 8.523  | 8.576 | 8.309 | 100.0%  | 10    |
1295   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1296   Load duration: 24.7742590904
1297   Full duration: 32.1246640682
1298
1299   test scenario CinderVolumes.create_snapshot_and_attach_volume
1300   +------------------------------------------------------------------------------------------------+
1301   |                                      Response Times (sec)                                      |
1302   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1303   | action                 | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1304   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1305   | cinder.create_volume   | 2.785  | 3.006  | 3.052  | 3.053  | 3.054  | 2.967  | 100.0%  | 10    |
1306   | cinder.create_snapshot | 2.339  | 2.436  | 2.475  | 2.481  | 2.486  | 2.419  | 100.0%  | 10    |
1307   | nova.attach_volume     | 7.797  | 7.994  | 11.939 | 13.348 | 14.758 | 9.194  | 100.0%  | 10    |
1308   | nova.detach_volume     | 3.106  | 5.458  | 5.926  | 6.833  | 7.741  | 5.44   | 100.0%  | 10    |
1309   | cinder.delete_snapshot | 2.187  | 2.348  | 2.417  | 2.439  | 2.462  | 2.348  | 100.0%  | 10    |
1310   | cinder.delete_volume   | 2.389  | 2.565  | 2.659  | 2.729  | 2.8    | 2.561  | 100.0%  | 10    |
1311   | total                  | 21.737 | 24.472 | 27.817 | 29.344 | 30.87  | 25.253 | 100.0%  | 10    |
1312   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1313   Load duration: 74.3525400162
1314   Full duration: 122.11897397
1315
1316   test scenario CinderVolumes.create_snapshot_and_attach_volume
1317   +------------------------------------------------------------------------------------------------+
1318   |                                      Response Times (sec)                                      |
1319   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1320   | action                 | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1321   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1322   | cinder.create_volume   | 2.84   | 2.872  | 2.934  | 2.988  | 3.042  | 2.889  | 100.0%  | 10    |
1323   | cinder.create_snapshot | 2.259  | 2.392  | 2.46   | 2.465  | 2.47   | 2.392  | 100.0%  | 10    |
1324   | nova.attach_volume     | 7.656  | 7.785  | 13.181 | 16.282 | 19.382 | 9.416  | 100.0%  | 10    |
1325   | nova.detach_volume     | 2.927  | 4.342  | 5.298  | 5.387  | 5.477  | 4.199  | 100.0%  | 10    |
1326   | cinder.delete_snapshot | 2.258  | 2.35   | 2.466  | 2.476  | 2.486  | 2.362  | 100.0%  | 10    |
1327   | cinder.delete_volume   | 2.334  | 2.597  | 2.665  | 2.671  | 2.678  | 2.553  | 100.0%  | 10    |
1328   | total                  | 21.266 | 23.837 | 27.072 | 30.307 | 33.542 | 24.349 | 100.0%  | 10    |
1329   +------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1330   Load duration: 69.1618478298
1331   Full duration: 114.061968088
1332
1333   2016-02-12 19:48:49,805 - run_rally - DEBUG - task_id : a9edf9cf-40a7-49be-8eb6-a24ec3b12338
1334   2016-02-12 19:48:49,805 - run_rally - DEBUG - running command line : rally task report a9edf9cf-40a7-49be-8eb6-a24ec3b12338 --out /home/opnfv/functest/results/rally/opnfv-cinder.html
1335   2016-02-12 19:48:50,531 - run_rally - DEBUG - running command line : rally task results a9edf9cf-40a7-49be-8eb6-a24ec3b12338
1336   2016-02-12 19:48:51,132 - run_rally - DEBUG - saving json file
1337   2016-02-12 19:48:51,138 - run_rally - DEBUG - Push result into DB
1338   2016-02-12 19:48:52,768 - run_rally - DEBUG - <Response [200]>
1339   2016-02-12 19:48:52,771 - run_rally - INFO - Test scenario: "cinder" OK.
1340
1341   2016-02-12 19:48:52,772 - run_rally - INFO - Starting test scenario "heat" ...
1342   2016-02-12 19:48:52,772 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-heat.yaml
1343   2016-02-12 19:48:52,982 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['heat'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1344   2016-02-12 19:55:40,270 - run_rally - INFO -
1345    Preparing input task
1346    Task  797423eb-9306-44f7-ac18-2f292a59a933: started
1347   Task 797423eb-9306-44f7-ac18-2f292a59a933: finished
1348
1349   test scenario HeatStacks.create_suspend_resume_delete_stack
1350   +-----------------------------------------------------------------------------------------+
1351   |                                  Response Times (sec)                                   |
1352   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1353   | action             | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1354   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1355   | heat.create_stack  | 2.744 | 3.193  | 3.515  | 3.614  | 3.714 | 3.186 | 100.0%  | 10    |
1356   | heat.suspend_stack | 0.363 | 0.757  | 1.601  | 1.669  | 1.737 | 1.01  | 100.0%  | 10    |
1357   | heat.resume_stack  | 0.465 | 1.026  | 1.542  | 1.641  | 1.741 | 1.035 | 100.0%  | 10    |
1358   | heat.delete_stack  | 0.658 | 1.516  | 1.583  | 1.647  | 1.71  | 1.434 | 100.0%  | 10    |
1359   | total              | 4.822 | 6.805  | 8.108  | 8.133  | 8.158 | 6.665 | 100.0%  | 10    |
1360   +--------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1361   Load duration: 19.812101841
1362   Full duration: 23.279335022
1363
1364   test scenario HeatStacks.create_and_delete_stack
1365   +----------------------------------------------------------------------------------------+
1366   |                                  Response Times (sec)                                  |
1367   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1368   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1369   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1370   | heat.create_stack | 3.014 | 3.189  | 3.303  | 3.33   | 3.356 | 3.191 | 100.0%  | 10    |
1371   | heat.delete_stack | 0.399 | 1.326  | 1.648  | 1.671  | 1.693 | 1.121 | 100.0%  | 10    |
1372   | total             | 3.696 | 4.497  | 4.87   | 4.935  | 5.0   | 4.312 | 100.0%  | 10    |
1373   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1374   Load duration: 12.8518810272
1375   Full duration: 16.4311740398
1376
1377   test scenario HeatStacks.create_and_delete_stack
1378   +-------------------------------------------------------------------------------------------+
1379   |                                   Response Times (sec)                                    |
1380   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1381   | action            | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1382   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1383   | heat.create_stack | 10.344 | 11.705 | 12.412 | 12.901 | 13.39  | 11.743 | 100.0%  | 10    |
1384   | heat.delete_stack | 6.739  | 7.311  | 8.145  | 8.368  | 8.591  | 7.526  | 100.0%  | 10    |
1385   | total             | 17.421 | 19.452 | 20.394 | 20.56  | 20.727 | 19.269 | 100.0%  | 10    |
1386   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1387   Load duration: 56.5501990318
1388   Full duration: 60.2050161362
1389
1390   test scenario HeatStacks.create_and_delete_stack
1391   +-------------------------------------------------------------------------------------------+
1392   |                                   Response Times (sec)                                    |
1393   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1394   | action            | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1395   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1396   | heat.create_stack | 12.973 | 14.566 | 16.672 | 17.288 | 17.904 | 14.923 | 100.0%  | 10    |
1397   | heat.delete_stack | 8.332  | 9.406  | 10.315 | 10.366 | 10.416 | 9.442  | 100.0%  | 10    |
1398   | total             | 22.036 | 24.111 | 25.932 | 26.489 | 27.045 | 24.365 | 100.0%  | 10    |
1399   +-------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1400   Load duration: 72.41437006
1401   Full duration: 76.2519450188
1402
1403   test scenario HeatStacks.list_stacks_and_resources
1404   +-----------------------------------------------------------------------------------------------------+
1405   |                                        Response Times (sec)                                         |
1406   +---------------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1407   | action                          | min   | median | 90%ile | 95%ile | max  | avg   | success | count |
1408   +---------------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1409   | heat.list_stacks                | 0.216 | 0.243  | 0.27   | 0.28   | 0.29 | 0.247 | 100.0%  | 10    |
1410   | heat.list_resources_of_0_stacks | 0.0   | 0.0    | 0.0    | 0.0    | 0.0  | 0.0   | 100.0%  | 10    |
1411   | total                           | 0.216 | 0.243  | 0.27   | 0.28   | 0.29 | 0.247 | 100.0%  | 10    |
1412   +---------------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1413   Load duration: 0.760275125504
1414   Full duration: 3.68153595924
1415
1416   test scenario HeatStacks.create_update_delete_stack
1417   +----------------------------------------------------------------------------------------+
1418   |                                  Response Times (sec)                                  |
1419   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1420   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1421   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1422   | heat.create_stack | 2.849 | 3.147  | 3.247  | 3.272  | 3.296 | 3.108 | 100.0%  | 10    |
1423   | heat.update_stack | 2.571 | 3.687  | 3.897  | 3.931  | 3.965 | 3.344 | 100.0%  | 10    |
1424   | heat.delete_stack | 1.19  | 1.508  | 1.705  | 1.818  | 1.931 | 1.527 | 100.0%  | 10    |
1425   | total             | 7.073 | 8.308  | 8.701  | 8.819  | 8.937 | 7.979 | 100.0%  | 10    |
1426   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1427   Load duration: 24.4536459446
1428   Full duration: 28.0561339855
1429
1430   test scenario HeatStacks.create_update_delete_stack
1431   +----------------------------------------------------------------------------------------+
1432   |                                  Response Times (sec)                                  |
1433   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1434   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1435   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1436   | heat.create_stack | 2.875 | 3.107  | 3.277  | 3.281  | 3.285 | 3.099 | 100.0%  | 10    |
1437   | heat.update_stack | 2.49  | 2.629  | 3.689  | 3.697  | 3.704 | 2.919 | 100.0%  | 10    |
1438   | heat.delete_stack | 1.189 | 1.625  | 1.69   | 1.692  | 1.694 | 1.567 | 100.0%  | 10    |
1439   | total             | 7.152 | 7.293  | 8.468  | 8.516  | 8.565 | 7.585 | 100.0%  | 10    |
1440   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1441   Load duration: 23.0466270447
1442   Full duration: 26.991339922
1443
1444   test scenario HeatStacks.create_update_delete_stack
1445   +------------------------------------------------------------------------------------------+
1446   |                                   Response Times (sec)                                   |
1447   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1448   | action            | min   | median | 90%ile | 95%ile | max    | avg    | success | count |
1449   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1450   | heat.create_stack | 2.94  | 3.24   | 3.417  | 3.516  | 3.616  | 3.249  | 100.0%  | 10    |
1451   | heat.update_stack | 4.858 | 5.085  | 6.009  | 6.069  | 6.128  | 5.318  | 100.0%  | 10    |
1452   | heat.delete_stack | 1.554 | 2.41   | 2.605  | 2.609  | 2.613  | 2.141  | 100.0%  | 10    |
1453   | total             | 9.806 | 10.624 | 11.784 | 11.86  | 11.936 | 10.708 | 100.0%  | 10    |
1454   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1455   Load duration: 32.2090818882
1456   Full duration: 36.5297718048
1457
1458   test scenario HeatStacks.create_update_delete_stack
1459   +-----------------------------------------------------------------------+
1460   |                         Response Times (sec)                          |
1461   +--------+-----+--------+--------+--------+-----+-----+---------+-------+
1462   | action | min | median | 90%ile | 95%ile | max | avg | success | count |
1463   +--------+-----+--------+--------+--------+-----+-----+---------+-------+
1464   | total  | n/a | n/a    | n/a    | n/a    | n/a | n/a | 0.0%    | 5     |
1465   +--------+-----+--------+--------+--------+-----+-----+---------+-------+
1466   Load duration: 7.52663493156
1467   Full duration: 15.8856461048
1468
1469   test scenario HeatStacks.create_update_delete_stack
1470   +------------------------------------------------------------------------------------------+
1471   |                                   Response Times (sec)                                   |
1472   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1473   | action            | min   | median | 90%ile | 95%ile | max    | avg    | success | count |
1474   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1475   | heat.create_stack | 2.829 | 3.098  | 3.332  | 3.388  | 3.444  | 3.119  | 100.0%  | 10    |
1476   | heat.update_stack | 4.893 | 5.104  | 6.156  | 6.213  | 6.271  | 5.286  | 100.0%  | 10    |
1477   | heat.delete_stack | 1.53  | 2.418  | 2.801  | 2.839  | 2.878  | 2.229  | 100.0%  | 10    |
1478   | total             | 9.528 | 10.794 | 11.094 | 11.558 | 12.022 | 10.634 | 100.0%  | 10    |
1479   +-------------------+-------+--------+--------+--------+--------+--------+---------+-------+
1480   Load duration: 31.4142270088
1481   Full duration: 35.4717001915
1482
1483   test scenario HeatStacks.create_update_delete_stack
1484   +----------------------------------------------------------------------------------------+
1485   |                                  Response Times (sec)                                  |
1486   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1487   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1488   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1489   | heat.create_stack | 3.073 | 3.16   | 3.387  | 3.39   | 3.394 | 3.199 | 100.0%  | 10    |
1490   | heat.update_stack | 2.579 | 3.762  | 3.901  | 3.912  | 3.923 | 3.576 | 100.0%  | 10    |
1491   | heat.delete_stack | 0.54  | 1.554  | 1.659  | 1.678  | 1.696 | 1.462 | 100.0%  | 10    |
1492   | total             | 7.205 | 8.538  | 8.665  | 8.713  | 8.76  | 8.236 | 100.0%  | 10    |
1493   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1494   Load duration: 25.6365950108
1495   Full duration: 29.4618060589
1496
1497   test scenario HeatStacks.create_and_list_stack
1498   +----------------------------------------------------------------------------------------+
1499   |                                  Response Times (sec)                                  |
1500   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1501   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1502   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1503   | heat.create_stack | 2.834 | 3.106  | 3.308  | 3.311  | 3.315 | 3.112 | 100.0%  | 10    |
1504   | heat.list_stacks  | 0.034 | 0.109  | 0.181  | 0.183  | 0.186 | 0.108 | 100.0%  | 10    |
1505   | total             | 2.882 | 3.243  | 3.368  | 3.425  | 3.483 | 3.22  | 100.0%  | 10    |
1506   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1507   Load duration: 9.69428515434
1508   Full duration: 17.0273709297
1509
1510   test scenario HeatStacks.create_check_delete_stack
1511   +----------------------------------------------------------------------------------------+
1512   |                                  Response Times (sec)                                  |
1513   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1514   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1515   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1516   | heat.create_stack | 2.933 | 3.189  | 3.295  | 3.297  | 3.3   | 3.159 | 100.0%  | 10    |
1517   | heat.check_stack  | 0.457 | 0.663  | 1.713  | 1.74   | 1.766 | 0.853 | 100.0%  | 10    |
1518   | heat.delete_stack | 0.719 | 1.632  | 1.905  | 1.912  | 1.92  | 1.593 | 100.0%  | 10    |
1519   | total             | 5.137 | 5.514  | 6.021  | 6.188  | 6.355 | 5.605 | 100.0%  | 10    |
1520   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1521   Load duration: 16.9900569916
1522   Full duration: 21.1466290951
1523
1524   2016-02-12 19:55:40,271 - run_rally - DEBUG - task_id : 797423eb-9306-44f7-ac18-2f292a59a933
1525   2016-02-12 19:55:40,271 - run_rally - DEBUG - running command line : rally task report 797423eb-9306-44f7-ac18-2f292a59a933 --out /home/opnfv/functest/results/rally/opnfv-heat.html
1526   2016-02-12 19:55:40,950 - run_rally - DEBUG - running command line : rally task results 797423eb-9306-44f7-ac18-2f292a59a933
1527   2016-02-12 19:55:41,547 - run_rally - DEBUG - saving json file
1528   2016-02-12 19:55:41,552 - run_rally - DEBUG - Push result into DB
1529   2016-02-12 19:55:43,174 - run_rally - DEBUG - <Response [200]>
1530   2016-02-12 19:55:43,177 - run_rally - INFO - Test scenario: "heat" Failed.
1531
1532   2016-02-12 19:55:43,178 - run_rally - INFO - Starting test scenario "keystone" ...
1533   2016-02-12 19:55:43,178 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-keystone.yaml
1534   2016-02-12 19:55:43,626 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['keystone'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1535   2016-02-12 19:57:11,993 - run_rally - INFO -
1536    Preparing input task
1537    Task  57d9692e-4def-4ee3-9b86-bfff622dc8d6: started
1538   Task 57d9692e-4def-4ee3-9b86-bfff622dc8d6: finished
1539
1540   test scenario KeystoneBasic.create_tenant_with_users
1541   +--------------------------------------------------------------------------------------------+
1542   |                                    Response Times (sec)                                    |
1543   +------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1544   | action                 | min   | median | 90%ile | 95%ile | max  | avg   | success | count |
1545   +------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1546   | keystone.create_tenant | 0.108 | 0.122  | 0.148  | 0.164  | 0.18 | 0.129 | 100.0%  | 10    |
1547   | keystone.create_users  | 0.649 | 0.69   | 0.75   | 0.755  | 0.76 | 0.694 | 100.0%  | 10    |
1548   | total                  | 0.767 | 0.802  | 0.898  | 0.919  | 0.94 | 0.823 | 100.0%  | 10    |
1549   +------------------------+-------+--------+--------+--------+------+-------+---------+-------+
1550   Load duration: 2.42953491211
1551   Full duration: 12.7415950298
1552
1553   test scenario KeystoneBasic.create_add_and_list_user_roles
1554   +-------------------------------------------------------------------------------------------+
1555   |                                   Response Times (sec)                                    |
1556   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1557   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1558   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1559   | keystone.create_role | 0.104 | 0.121  | 0.149  | 0.15   | 0.151 | 0.126 | 100.0%  | 10    |
1560   | keystone.add_role    | 0.087 | 0.095  | 0.124  | 0.129  | 0.134 | 0.101 | 100.0%  | 10    |
1561   | keystone.list_roles  | 0.051 | 0.058  | 0.072  | 0.075  | 0.078 | 0.062 | 100.0%  | 10    |
1562   | total                | 0.259 | 0.286  | 0.314  | 0.318  | 0.321 | 0.289 | 100.0%  | 10    |
1563   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1564   Load duration: 0.864060878754
1565   Full duration: 6.40814208984
1566
1567   test scenario KeystoneBasic.add_and_remove_user_role
1568   +-------------------------------------------------------------------------------------------+
1569   |                                   Response Times (sec)                                    |
1570   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1571   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1572   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1573   | keystone.create_role | 0.115 | 0.222  | 0.285  | 0.305  | 0.325 | 0.207 | 100.0%  | 10    |
1574   | keystone.add_role    | 0.086 | 0.113  | 0.147  | 0.18   | 0.213 | 0.121 | 100.0%  | 10    |
1575   | keystone.remove_role | 0.058 | 0.072  | 0.18   | 0.188  | 0.196 | 0.108 | 100.0%  | 10    |
1576   | total                | 0.281 | 0.453  | 0.574  | 0.586  | 0.599 | 0.436 | 100.0%  | 10    |
1577   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1578   Load duration: 1.40016198158
1579   Full duration: 7.08734297752
1580
1581   test scenario KeystoneBasic.create_update_and_delete_tenant
1582   +---------------------------------------------------------------------------------------------+
1583   |                                    Response Times (sec)                                     |
1584   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1585   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1586   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1587   | keystone.create_tenant | 0.125 | 0.222  | 0.273  | 0.274  | 0.274 | 0.2   | 100.0%  | 10    |
1588   | keystone.update_tenant | 0.049 | 0.057  | 0.076  | 0.12   | 0.164 | 0.067 | 100.0%  | 10    |
1589   | keystone.delete_tenant | 0.121 | 0.141  | 0.208  | 0.247  | 0.286 | 0.158 | 100.0%  | 10    |
1590   | total                  | 0.319 | 0.414  | 0.545  | 0.582  | 0.619 | 0.426 | 100.0%  | 10    |
1591   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1592   Load duration: 1.2874519825
1593   Full duration: 5.71538686752
1594
1595   test scenario KeystoneBasic.create_and_delete_service
1596   +----------------------------------------------------------------------------------------------+
1597   |                                     Response Times (sec)                                     |
1598   +-------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1599   | action                  | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1600   +-------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1601   | keystone.create_service | 0.114 | 0.128  | 0.16   | 0.16   | 0.16  | 0.131 | 100.0%  | 10    |
1602   | keystone.delete_service | 0.058 | 0.062  | 0.071  | 0.089  | 0.108 | 0.066 | 100.0%  | 10    |
1603   | total                   | 0.177 | 0.194  | 0.222  | 0.223  | 0.223 | 0.198 | 100.0%  | 10    |
1604   +-------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1605   Load duration: 0.619410991669
1606   Full duration: 4.71141886711
1607
1608   test scenario KeystoneBasic.create_tenant
1609   +---------------------------------------------------------------------------------------------+
1610   |                                    Response Times (sec)                                     |
1611   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1612   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1613   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1614   | keystone.create_tenant | 0.113 | 0.132  | 0.165  | 0.166  | 0.166 | 0.133 | 100.0%  | 10    |
1615   | total                  | 0.113 | 0.132  | 0.165  | 0.166  | 0.166 | 0.133 | 100.0%  | 10    |
1616   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1617   Load duration: 0.391160011292
1618   Full duration: 4.46575784683
1619
1620   test scenario KeystoneBasic.create_user
1621   +-------------------------------------------------------------------------------------------+
1622   |                                   Response Times (sec)                                    |
1623   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1624   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1625   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1626   | keystone.create_user | 0.129 | 0.145  | 0.188  | 0.188  | 0.188 | 0.156 | 100.0%  | 10    |
1627   | total                | 0.129 | 0.145  | 0.188  | 0.188  | 0.188 | 0.156 | 100.0%  | 10    |
1628   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1629   Load duration: 0.482604026794
1630   Full duration: 4.4991080761
1631
1632   test scenario KeystoneBasic.create_and_list_tenants
1633   +---------------------------------------------------------------------------------------------+
1634   |                                    Response Times (sec)                                     |
1635   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1636   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1637   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1638   | keystone.create_tenant | 0.116 | 0.144  | 0.167  | 0.169  | 0.171 | 0.144 | 100.0%  | 10    |
1639   | keystone.list_tenants  | 0.047 | 0.056  | 0.096  | 0.099  | 0.101 | 0.064 | 100.0%  | 10    |
1640   | total                  | 0.172 | 0.214  | 0.227  | 0.227  | 0.228 | 0.208 | 100.0%  | 10    |
1641   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1642   Load duration: 0.628124952316
1643   Full duration: 6.31660103798
1644
1645   test scenario KeystoneBasic.create_and_delete_role
1646   +-------------------------------------------------------------------------------------------+
1647   |                                   Response Times (sec)                                    |
1648   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1649   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1650   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1651   | keystone.create_role | 0.124 | 0.242  | 0.282  | 0.293  | 0.304 | 0.21  | 100.0%  | 10    |
1652   | keystone.delete_role | 0.112 | 0.131  | 0.174  | 0.203  | 0.231 | 0.142 | 100.0%  | 10    |
1653   | total                | 0.24  | 0.369  | 0.429  | 0.469  | 0.509 | 0.352 | 100.0%  | 10    |
1654   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1655   Load duration: 1.05624604225
1656   Full duration: 5.52495193481
1657
1658   test scenario KeystoneBasic.get_entities
1659   +---------------------------------------------------------------------------------------------+
1660   |                                    Response Times (sec)                                     |
1661   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1662   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1663   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1664   | keystone.create_tenant | 0.115 | 0.129  | 0.16   | 0.172  | 0.183 | 0.139 | 100.0%  | 10    |
1665   | keystone.create_user   | 0.062 | 0.074  | 0.106  | 0.11   | 0.114 | 0.082 | 100.0%  | 10    |
1666   | keystone.create_role   | 0.048 | 0.055  | 0.096  | 0.101  | 0.106 | 0.064 | 100.0%  | 10    |
1667   | keystone.get_tenant    | 0.043 | 0.045  | 0.061  | 0.071  | 0.081 | 0.051 | 100.0%  | 10    |
1668   | keystone.get_user      | 0.047 | 0.055  | 0.066  | 0.069  | 0.071 | 0.056 | 100.0%  | 10    |
1669   | keystone.get_role      | 0.046 | 0.051  | 0.065  | 0.066  | 0.067 | 0.054 | 100.0%  | 10    |
1670   | keystone.service_list  | 0.045 | 0.052  | 0.063  | 0.064  | 0.065 | 0.054 | 100.0%  | 10    |
1671   | keystone.get_service   | 0.042 | 0.055  | 0.068  | 0.079  | 0.089 | 0.058 | 100.0%  | 10    |
1672   | total                  | 0.53  | 0.553  | 0.58   | 0.597  | 0.615 | 0.557 | 100.0%  | 10    |
1673   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1674   Load duration: 1.73635601997
1675   Full duration: 10.0342190266
1676
1677   test scenario KeystoneBasic.create_and_list_users
1678   +-------------------------------------------------------------------------------------------+
1679   |                                   Response Times (sec)                                    |
1680   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1681   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1682   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1683   | keystone.create_user | 0.13  | 0.142  | 0.157  | 0.165  | 0.173 | 0.145 | 100.0%  | 10    |
1684   | keystone.list_users  | 0.046 | 0.053  | 0.084  | 0.089  | 0.095 | 0.059 | 100.0%  | 10    |
1685   | total                | 0.178 | 0.202  | 0.229  | 0.232  | 0.234 | 0.203 | 100.0%  | 10    |
1686   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1687   Load duration: 0.646016120911
1688   Full duration: 4.92132210732
1689
1690   2016-02-12 19:57:11,994 - run_rally - DEBUG - task_id : 57d9692e-4def-4ee3-9b86-bfff622dc8d6
1691   2016-02-12 19:57:11,994 - run_rally - DEBUG - running command line : rally task report 57d9692e-4def-4ee3-9b86-bfff622dc8d6 --out /home/opnfv/functest/results/rally/opnfv-keystone.html
1692   2016-02-12 19:57:12,654 - run_rally - DEBUG - running command line : rally task results 57d9692e-4def-4ee3-9b86-bfff622dc8d6
1693   2016-02-12 19:57:13,252 - run_rally - DEBUG - saving json file
1694   2016-02-12 19:57:13,256 - run_rally - DEBUG - Push result into DB
1695   2016-02-12 19:57:14,454 - run_rally - DEBUG - <Response [200]>
1696   2016-02-12 19:57:14,456 - run_rally - INFO - Test scenario: "keystone" OK.
1697
1698   2016-02-12 19:57:14,457 - run_rally - INFO - Starting test scenario "neutron" ...
1699   2016-02-12 19:57:14,457 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-neutron.yaml
1700   2016-02-12 19:57:14,836 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['neutron'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1701   2016-02-12 20:02:28,457 - run_rally - INFO -
1702    Preparing input task
1703    Task  e48913d0-c413-4744-83ec-2b67e8f0ed62: started
1704   Task e48913d0-c413-4744-83ec-2b67e8f0ed62: finished
1705
1706   test scenario NeutronNetworks.create_and_delete_ports
1707   +------------------------------------------------------------------------------------------+
1708   |                                   Response Times (sec)                                   |
1709   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1710   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1711   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1712   | neutron.create_port | 0.399 | 0.535  | 0.643  | 0.664  | 0.686 | 0.532 | 100.0%  | 10    |
1713   | neutron.delete_port | 0.144 | 0.157  | 0.316  | 0.392  | 0.469 | 0.215 | 100.0%  | 10    |
1714   | total               | 0.552 | 0.731  | 0.93   | 0.959  | 0.989 | 0.747 | 100.0%  | 10    |
1715   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1716   Load duration: 2.22487306595
1717   Full duration: 26.1480481625
1718
1719   test scenario NeutronNetworks.create_and_list_routers
1720   +---------------------------------------------------------------------------------------------------+
1721   |                                       Response Times (sec)                                        |
1722   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1723   | action                       | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1724   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1725   | neutron.create_subnet        | 0.419 | 0.483  | 0.566  | 0.57   | 0.574 | 0.482 | 100.0%  | 10    |
1726   | neutron.create_router        | 0.035 | 0.041  | 0.191  | 0.201  | 0.211 | 0.086 | 100.0%  | 10    |
1727   | neutron.add_interface_router | 0.233 | 0.256  | 0.532  | 0.563  | 0.595 | 0.323 | 100.0%  | 10    |
1728   | neutron.list_routers         | 0.032 | 0.162  | 0.183  | 0.256  | 0.329 | 0.141 | 100.0%  | 10    |
1729   | total                        | 0.752 | 1.012  | 1.399  | 1.433  | 1.467 | 1.032 | 100.0%  | 10    |
1730   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1731   Load duration: 2.85454916954
1732   Full duration: 28.7914018631
1733
1734   test scenario NeutronNetworks.create_and_delete_routers
1735   +------------------------------------------------------------------------------------------------------+
1736   |                                         Response Times (sec)                                         |
1737   +---------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1738   | action                          | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1739   +---------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1740   | neutron.create_subnet           | 0.388 | 0.454  | 0.651  | 0.652  | 0.654 | 0.493 | 100.0%  | 10    |
1741   | neutron.create_router           | 0.033 | 0.106  | 0.186  | 0.193  | 0.2   | 0.109 | 100.0%  | 10    |
1742   | neutron.add_interface_router    | 0.229 | 0.371  | 0.412  | 0.421  | 0.43  | 0.34  | 100.0%  | 10    |
1743   | neutron.remove_interface_router | 0.16  | 0.23   | 0.415  | 0.474  | 0.532 | 0.276 | 100.0%  | 10    |
1744   | neutron.delete_router           | 0.117 | 0.128  | 0.266  | 0.272  | 0.277 | 0.174 | 100.0%  | 10    |
1745   | total                           | 1.101 | 1.28   | 1.776  | 1.813  | 1.851 | 1.392 | 100.0%  | 10    |
1746   +---------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1747   Load duration: 4.21995615959
1748   Full duration: 29.2232439518
1749
1750   test scenario NeutronNetworks.create_and_list_ports
1751   +------------------------------------------------------------------------------------------+
1752   |                                   Response Times (sec)                                   |
1753   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1754   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1755   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1756   | neutron.create_port | 0.438 | 0.52   | 0.742  | 0.744  | 0.747 | 0.57  | 100.0%  | 10    |
1757   | neutron.list_ports  | 0.125 | 0.284  | 0.421  | 0.448  | 0.474 | 0.279 | 100.0%  | 10    |
1758   | total               | 0.664 | 0.793  | 1.036  | 1.092  | 1.149 | 0.849 | 100.0%  | 10    |
1759   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1760   Load duration: 2.59459614754
1761   Full duration: 27.4613380432
1762
1763   test scenario NeutronNetworks.create_and_delete_subnets
1764   +--------------------------------------------------------------------------------------------+
1765   |                                    Response Times (sec)                                    |
1766   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1767   | action                | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1768   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1769   | neutron.create_subnet | 0.401 | 0.455  | 0.489  | 0.518  | 0.547 | 0.457 | 100.0%  | 10    |
1770   | neutron.delete_subnet | 0.14  | 0.286  | 0.324  | 0.365  | 0.406 | 0.25  | 100.0%  | 10    |
1771   | total                 | 0.544 | 0.726  | 0.858  | 0.86   | 0.862 | 0.707 | 100.0%  | 10    |
1772   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1773   Load duration: 2.16699886322
1774   Full duration: 25.9957101345
1775
1776   test scenario NeutronNetworks.create_and_delete_networks
1777   +---------------------------------------------------------------------------------------------+
1778   |                                    Response Times (sec)                                     |
1779   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1780   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1781   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1782   | neutron.create_network | 0.321 | 0.349  | 0.389  | 0.39   | 0.391 | 0.355 | 100.0%  | 10    |
1783   | neutron.delete_network | 0.109 | 0.126  | 0.269  | 0.31   | 0.351 | 0.171 | 100.0%  | 10    |
1784   | total                  | 0.431 | 0.495  | 0.617  | 0.679  | 0.741 | 0.526 | 100.0%  | 10    |
1785   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1786   Load duration: 1.58180904388
1787   Full duration: 15.3088929653
1788
1789   test scenario NeutronNetworks.create_and_list_networks
1790   +---------------------------------------------------------------------------------------------+
1791   |                                    Response Times (sec)                                     |
1792   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1793   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1794   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1795   | neutron.create_network | 0.302 | 0.351  | 0.374  | 0.389  | 0.404 | 0.353 | 100.0%  | 10    |
1796   | neutron.list_networks  | 0.041 | 0.054  | 0.209  | 0.217  | 0.225 | 0.11  | 100.0%  | 10    |
1797   | total                  | 0.343 | 0.416  | 0.593  | 0.595  | 0.597 | 0.464 | 100.0%  | 10    |
1798   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1799   Load duration: 1.31170892715
1800   Full duration: 16.9302289486
1801
1802   test scenario NeutronNetworks.create_and_update_routers
1803   +---------------------------------------------------------------------------------------------------+
1804   |                                       Response Times (sec)                                        |
1805   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1806   | action                       | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1807   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1808   | neutron.create_subnet        | 0.398 | 0.445  | 0.598  | 0.664  | 0.729 | 0.483 | 100.0%  | 10    |
1809   | neutron.create_router        | 0.033 | 0.172  | 0.185  | 0.19   | 0.194 | 0.135 | 100.0%  | 10    |
1810   | neutron.add_interface_router | 0.23  | 0.301  | 0.403  | 0.406  | 0.409 | 0.309 | 100.0%  | 10    |
1811   | neutron.update_router        | 0.082 | 0.168  | 0.286  | 0.305  | 0.323 | 0.179 | 100.0%  | 10    |
1812   | total                        | 0.888 | 1.115  | 1.258  | 1.267  | 1.276 | 1.106 | 100.0%  | 10    |
1813   +------------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1814   Load duration: 3.1909840107
1815   Full duration: 29.4671947956
1816
1817   test scenario NeutronNetworks.create_and_update_networks
1818   +---------------------------------------------------------------------------------------------+
1819   |                                    Response Times (sec)                                     |
1820   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1821   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1822   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1823   | neutron.create_network | 0.32  | 0.431  | 0.497  | 0.498  | 0.499 | 0.418 | 100.0%  | 10    |
1824   | neutron.update_network | 0.105 | 0.309  | 0.472  | 0.483  | 0.495 | 0.301 | 100.0%  | 10    |
1825   | total                  | 0.427 | 0.762  | 0.97   | 0.978  | 0.987 | 0.72  | 100.0%  | 10    |
1826   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1827   Load duration: 2.14427304268
1828   Full duration: 18.0257649422
1829
1830   test scenario NeutronNetworks.create_and_update_ports
1831   +------------------------------------------------------------------------------------------+
1832   |                                   Response Times (sec)                                   |
1833   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1834   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1835   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1836   | neutron.create_port | 0.417 | 0.509  | 0.627  | 0.667  | 0.707 | 0.529 | 100.0%  | 10    |
1837   | neutron.update_port | 0.11  | 0.262  | 0.372  | 0.396  | 0.421 | 0.25  | 100.0%  | 10    |
1838   | total               | 0.571 | 0.756  | 1.042  | 1.058  | 1.073 | 0.779 | 100.0%  | 10    |
1839   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1840   Load duration: 2.27396202087
1841   Full duration: 27.3324229717
1842
1843   test scenario NeutronNetworks.create_and_list_subnets
1844   +--------------------------------------------------------------------------------------------+
1845   |                                    Response Times (sec)                                    |
1846   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1847   | action                | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1848   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1849   | neutron.create_subnet | 0.426 | 0.51   | 0.568  | 0.569  | 0.57  | 0.502 | 100.0%  | 10    |
1850   | neutron.list_subnets  | 0.059 | 0.063  | 0.223  | 0.234  | 0.245 | 0.111 | 100.0%  | 10    |
1851   | total                 | 0.487 | 0.62   | 0.712  | 0.758  | 0.803 | 0.613 | 100.0%  | 10    |
1852   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1853   Load duration: 1.74596190453
1854   Full duration: 27.4602999687
1855
1856   test scenario NeutronNetworks.create_and_update_subnets
1857   +--------------------------------------------------------------------------------------------+
1858   |                                    Response Times (sec)                                    |
1859   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1860   | action                | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1861   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1862   | neutron.create_subnet | 0.411 | 0.435  | 0.536  | 0.56   | 0.584 | 0.46  | 100.0%  | 10    |
1863   | neutron.update_subnet | 0.16  | 0.182  | 0.338  | 0.411  | 0.484 | 0.246 | 100.0%  | 10    |
1864   | total                 | 0.588 | 0.674  | 0.905  | 0.915  | 0.924 | 0.706 | 100.0%  | 10    |
1865   +-----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1866   Load duration: 2.05780911446
1867   Full duration: 27.6062719822
1868
1869   2016-02-12 20:02:28,458 - run_rally - DEBUG - task_id : e48913d0-c413-4744-83ec-2b67e8f0ed62
1870   2016-02-12 20:02:28,458 - run_rally - DEBUG - running command line : rally task report e48913d0-c413-4744-83ec-2b67e8f0ed62 --out /home/opnfv/functest/results/rally/opnfv-neutron.html
1871   2016-02-12 20:02:29,109 - run_rally - DEBUG - running command line : rally task results e48913d0-c413-4744-83ec-2b67e8f0ed62
1872   2016-02-12 20:02:29,699 - run_rally - DEBUG - saving json file
1873   2016-02-12 20:02:29,704 - run_rally - DEBUG - Push result into DB
1874   2016-02-12 20:02:31,476 - run_rally - DEBUG - <Response [200]>
1875   2016-02-12 20:02:31,478 - run_rally - INFO - Test scenario: "neutron" OK.
1876
1877   2016-02-12 20:02:31,479 - run_rally - INFO - Starting test scenario "nova" ...
1878   2016-02-12 20:02:31,479 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-nova.yaml
1879   2016-02-12 20:02:31,983 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['nova'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
1880   2016-02-12 20:28:19,817 - run_rally - INFO -
1881    Preparing input task
1882    Task  86ea3837-f2e0-40c9-94c4-4716ca177f60: started
1883   Task 86ea3837-f2e0-40c9-94c4-4716ca177f60: finished
1884
1885   test scenario NovaKeypair.create_and_delete_keypair
1886   +------------------------------------------------------------------------------------------+
1887   |                                   Response Times (sec)                                   |
1888   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1889   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1890   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1891   | nova.create_keypair | 0.372 | 0.481  | 0.526  | 0.528  | 0.53  | 0.465 | 100.0%  | 10    |
1892   | nova.delete_keypair | 0.012 | 0.017  | 0.019  | 0.02   | 0.02  | 0.016 | 100.0%  | 10    |
1893   | total               | 0.393 | 0.497  | 0.539  | 0.544  | 0.549 | 0.482 | 100.0%  | 10    |
1894   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1895   Load duration: 1.48728299141
1896   Full duration: 15.9261510372
1897
1898   test scenario NovaServers.snapshot_server
1899   +---------------------------------------------------------------------------------------------------+
1900   |                                       Response Times (sec)                                        |
1901   +------------------------+--------+--------+---------+---------+---------+--------+---------+-------+
1902   | action                 | min    | median | 90%ile  | 95%ile  | max     | avg    | success | count |
1903   +------------------------+--------+--------+---------+---------+---------+--------+---------+-------+
1904   | nova.boot_server       | 3.667  | 5.588  | 6.458   | 6.579   | 6.699   | 5.6    | 100.0%  | 10    |
1905   | nova.create_image      | 28.485 | 46.423 | 73.882  | 74.768  | 75.654  | 50.445 | 100.0%  | 10    |
1906   | nova.delete_server     | 2.402  | 2.583  | 2.776   | 2.814   | 2.853   | 2.602  | 100.0%  | 10    |
1907   | nova.boot_server (2)   | 15.754 | 21.941 | 36.956  | 38.716  | 40.476  | 25.503 | 100.0%  | 10    |
1908   | nova.delete_server (2) | 2.387  | 3.643  | 4.941   | 5.086   | 5.23    | 3.723  | 100.0%  | 10    |
1909   | nova.delete_image      | 0.196  | 0.611  | 1.169   | 1.896   | 2.624   | 0.787  | 100.0%  | 10    |
1910   | total                  | 64.165 | 80.28  | 120.393 | 124.468 | 128.543 | 88.661 | 100.0%  | 10    |
1911   +------------------------+--------+--------+---------+---------+---------+--------+---------+-------+
1912   Load duration: 251.648657084
1913   Full duration: 276.949105024
1914
1915   test scenario NovaKeypair.boot_and_delete_server_with_keypair
1916   +-------------------------------------------------------------------------------------------+
1917   |                                   Response Times (sec)                                    |
1918   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1919   | action              | min   | median | 90%ile | 95%ile | max    | avg   | success | count |
1920   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1921   | nova.create_keypair | 0.35  | 0.468  | 0.647  | 0.703  | 0.758  | 0.502 | 100.0%  | 10    |
1922   | nova.boot_server    | 3.271 | 4.466  | 5.648  | 5.68   | 5.712  | 4.477 | 100.0%  | 10    |
1923   | nova.delete_server  | 2.357 | 2.413  | 4.727  | 4.771  | 4.815  | 2.907 | 100.0%  | 10    |
1924   | nova.delete_keypair | 0.013 | 0.017  | 0.02   | 0.024  | 0.028  | 0.017 | 100.0%  | 10    |
1925   | total               | 6.086 | 7.272  | 10.906 | 11.005 | 11.104 | 7.903 | 100.0%  | 10    |
1926   +---------------------+-------+--------+--------+--------+--------+-------+---------+-------+
1927   Load duration: 21.4185590744
1928   Full duration: 44.9553050995
1929
1930   test scenario NovaKeypair.create_and_list_keypairs
1931   +------------------------------------------------------------------------------------------+
1932   |                                   Response Times (sec)                                   |
1933   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1934   | action              | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
1935   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1936   | nova.create_keypair | 0.347 | 0.435  | 0.529  | 0.575  | 0.622 | 0.446 | 100.0%  | 10    |
1937   | nova.list_keypairs  | 0.012 | 0.017  | 0.021  | 0.021  | 0.021 | 0.017 | 100.0%  | 10    |
1938   | total               | 0.36  | 0.451  | 0.549  | 0.596  | 0.644 | 0.463 | 100.0%  | 10    |
1939   +---------------------+-------+--------+--------+--------+-------+-------+---------+-------+
1940   Load duration: 1.30683994293
1941   Full duration: 17.9540309906
1942
1943   test scenario NovaServers.list_servers
1944   +--------------------------------------------------------------------------------------+
1945   |                                 Response Times (sec)                                 |
1946   +-------------------+------+--------+--------+--------+-------+------+---------+-------+
1947   | action            | min  | median | 90%ile | 95%ile | max   | avg  | success | count |
1948   +-------------------+------+--------+--------+--------+-------+------+---------+-------+
1949   | nova.list_servers | 0.57 | 0.656  | 0.724  | 0.726  | 0.728 | 0.66 | 100.0%  | 10    |
1950   | total             | 0.57 | 0.656  | 0.724  | 0.726  | 0.728 | 0.66 | 100.0%  | 10    |
1951   +-------------------+------+--------+--------+--------+-------+------+---------+-------+
1952   Load duration: 1.95767593384
1953   Full duration: 50.1962890625
1954
1955   test scenario NovaServers.resize_server
1956   +---------------------------------------------------------------------------------------------+
1957   |                                    Response Times (sec)                                     |
1958   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1959   | action              | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1960   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1961   | nova.boot_server    | 3.571  | 5.812  | 6.108  | 6.218  | 6.328  | 5.346  | 100.0%  | 10    |
1962   | nova.resize         | 21.133 | 41.802 | 41.975 | 42.053 | 42.131 | 33.688 | 100.0%  | 10    |
1963   | nova.resize_confirm | 2.372  | 2.391  | 2.549  | 2.554  | 2.56   | 2.441  | 100.0%  | 10    |
1964   | nova.delete_server  | 2.414  | 2.599  | 4.526  | 4.579  | 4.633  | 3.318  | 100.0%  | 10    |
1965   | total               | 30.002 | 52.747 | 55.047 | 55.073 | 55.1   | 44.793 | 100.0%  | 10    |
1966   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1967   Load duration: 122.701140881
1968   Full duration: 137.509846926
1969
1970   test scenario NovaServers.boot_server_from_volume_and_delete
1971   +----------------------------------------------------------------------------------------------+
1972   |                                     Response Times (sec)                                     |
1973   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1974   | action               | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1975   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1976   | cinder.create_volume | 3.383  | 4.734  | 6.038  | 6.054  | 6.069  | 4.777  | 100.0%  | 10    |
1977   | nova.boot_server     | 8.153  | 9.391  | 11.581 | 12.372 | 13.164 | 9.722  | 100.0%  | 10    |
1978   | nova.delete_server   | 4.524  | 4.692  | 5.062  | 6.058  | 7.053  | 4.935  | 100.0%  | 10    |
1979   | total                | 16.523 | 19.055 | 22.314 | 23.115 | 23.916 | 19.435 | 100.0%  | 10    |
1980   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1981   Load duration: 56.2685899734
1982   Full duration: 88.1011340618
1983
1984   test scenario NovaServers.boot_and_migrate_server
1985   +---------------------------------------------------------------------------------------------+
1986   |                                    Response Times (sec)                                     |
1987   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1988   | action              | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
1989   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1990   | nova.boot_server    | 3.51   | 4.767  | 6.246  | 6.247  | 6.248  | 5.033  | 100.0%  | 10    |
1991   | nova.stop_server    | 4.665  | 13.7   | 15.919 | 16.024 | 16.129 | 10.667 | 100.0%  | 10    |
1992   | nova.migrate        | 14.448 | 18.934 | 31.729 | 31.889 | 32.049 | 21.453 | 100.0%  | 10    |
1993   | nova.resize_confirm | 2.392  | 2.41   | 2.476  | 2.523  | 2.57   | 2.431  | 100.0%  | 10    |
1994   | nova.delete_server  | 2.361  | 2.393  | 2.47   | 2.508  | 2.545  | 2.413  | 100.0%  | 10    |
1995   | total               | 30.988 | 37.377 | 58.67  | 58.979 | 59.289 | 41.999 | 100.0%  | 10    |
1996   +---------------------+--------+--------+--------+--------+--------+--------+---------+-------+
1997   Load duration: 120.644536018
1998   Full duration: 135.838603973
1999
2000   test scenario NovaServers.boot_and_delete_server
2001   +------------------------------------------------------------------------------------------+
2002   |                                   Response Times (sec)                                   |
2003   +--------------------+-------+--------+--------+--------+--------+-------+---------+-------+
2004   | action             | min   | median | 90%ile | 95%ile | max    | avg   | success | count |
2005   +--------------------+-------+--------+--------+--------+--------+-------+---------+-------+
2006   | nova.boot_server   | 3.511 | 6.17   | 7.23   | 7.245  | 7.259  | 5.929 | 100.0%  | 10    |
2007   | nova.delete_server | 2.401 | 4.626  | 4.875  | 4.9    | 4.924  | 3.876 | 100.0%  | 10    |
2008   | total              | 6.099 | 10.839 | 11.973 | 12.035 | 12.097 | 9.805 | 100.0%  | 10    |
2009   +--------------------+-------+--------+--------+--------+--------+-------+---------+-------+
2010   Load duration: 28.1878061295
2011   Full duration: 53.0389208794
2012
2013   test scenario NovaServers.boot_and_rebuild_server
2014   +--------------------------------------------------------------------------------------------+
2015   |                                    Response Times (sec)                                    |
2016   +---------------------+-------+--------+--------+--------+--------+--------+---------+-------+
2017   | action              | min   | median | 90%ile | 95%ile | max    | avg    | success | count |
2018   +---------------------+-------+--------+--------+--------+--------+--------+---------+-------+
2019   | nova.boot_server    | 3.396 | 4.751  | 5.961  | 5.997  | 6.033  | 4.765  | 100.0%  | 10    |
2020   | nova.rebuild_server | 6.412 | 11.396 | 17.143 | 17.212 | 17.281 | 11.678 | 100.0%  | 10    |
2021   | nova.delete_server  | 2.381 | 2.432  | 2.57   | 2.572  | 2.575  | 2.465  | 100.0%  | 10    |
2022   | total               | 13.56 | 18.646 | 24.603 | 25.08  | 25.558 | 18.908 | 100.0%  | 10    |
2023   +---------------------+-------+--------+--------+--------+--------+--------+---------+-------+
2024   Load duration: 51.1383721828
2025   Full duration: 74.9763679504
2026
2027   test scenario NovaSecGroup.create_and_list_secgroups
2028   +--------------------------------------------------------------------------------------------------------+
2029   |                                          Response Times (sec)                                          |
2030   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2031   | action                         | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
2032   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2033   | nova.create_10_security_groups | 1.405  | 1.683  | 1.794  | 1.824  | 1.855  | 1.669  | 100.0%  | 10    |
2034   | nova.create_100_rules          | 8.981  | 10.227 | 10.547 | 10.572 | 10.598 | 9.996  | 100.0%  | 10    |
2035   | nova.list_security_groups      | 0.089  | 0.152  | 0.208  | 0.216  | 0.225  | 0.158  | 100.0%  | 10    |
2036   | total                          | 10.845 | 11.986 | 12.358 | 12.45  | 12.541 | 11.823 | 100.0%  | 10    |
2037   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2038   Load duration: 34.9436230659
2039   Full duration: 63.4042258263
2040
2041   test scenario NovaSecGroup.create_and_delete_secgroups
2042   +--------------------------------------------------------------------------------------------------------+
2043   |                                          Response Times (sec)                                          |
2044   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2045   | action                         | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
2046   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2047   | nova.create_10_security_groups | 1.574  | 1.855  | 2.164  | 2.264  | 2.363  | 1.899  | 100.0%  | 10    |
2048   | nova.create_100_rules          | 8.508  | 9.445  | 10.081 | 10.164 | 10.247 | 9.476  | 100.0%  | 10    |
2049   | nova.delete_10_security_groups | 0.751  | 0.892  | 1.01   | 1.038  | 1.066  | 0.897  | 100.0%  | 10    |
2050   | total                          | 11.131 | 12.394 | 12.807 | 12.865 | 12.923 | 12.272 | 100.0%  | 10    |
2051   +--------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2052   Load duration: 36.2206399441
2053   Full duration: 51.0607750416
2054
2055   test scenario NovaServers.boot_and_bounce_server
2056   +---------------------------------------------------------------------------------------------------+
2057   |                                       Response Times (sec)                                        |
2058   +-------------------------+--------+--------+--------+---------+---------+--------+---------+-------+
2059   | action                  | min    | median | 90%ile | 95%ile  | max     | avg    | success | count |
2060   +-------------------------+--------+--------+--------+---------+---------+--------+---------+-------+
2061   | nova.boot_server        | 3.685  | 4.768  | 5.396  | 5.806   | 6.216   | 4.714  | 100.0%  | 10    |
2062   | nova.reboot_server      | 4.412  | 4.608  | 4.722  | 4.792   | 4.863   | 4.599  | 100.0%  | 10    |
2063   | nova.soft_reboot_server | 6.743  | 6.895  | 18.97  | 72.539  | 126.108 | 18.82  | 100.0%  | 10    |
2064   | nova.stop_server        | 4.633  | 4.808  | 5.936  | 10.708  | 15.48   | 5.83   | 100.0%  | 10    |
2065   | nova.start_server       | 2.619  | 2.688  | 2.818  | 2.84    | 2.861   | 2.717  | 100.0%  | 10    |
2066   | nova.rescue_server      | 6.606  | 11.129 | 17.669 | 17.772  | 17.876  | 11.753 | 100.0%  | 10    |
2067   | nova.unrescue_server    | 2.314  | 4.496  | 4.579  | 4.626   | 4.673   | 4.086  | 100.0%  | 10    |
2068   | nova.delete_server      | 2.369  | 2.395  | 2.543  | 2.544   | 2.546   | 2.437  | 100.0%  | 10    |
2069   | total                   | 36.138 | 44.417 | 61.416 | 114.546 | 167.676 | 54.996 | 100.0%  | 10    |
2070   +-------------------------+--------+--------+--------+---------+---------+--------+---------+-------+
2071   Load duration: 167.702675819
2072   Full duration: 192.379112959
2073
2074   test scenario NovaServers.boot_server
2075   +---------------------------------------------------------------------------------------+
2076   |                                 Response Times (sec)                                  |
2077   +------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2078   | action           | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2079   +------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2080   | nova.boot_server | 3.314 | 4.815  | 5.794  | 5.963  | 6.131 | 4.735 | 100.0%  | 10    |
2081   | total            | 3.314 | 4.815  | 5.795  | 5.963  | 6.131 | 4.735 | 100.0%  | 10    |
2082   +------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2083   Load duration: 14.9615139961
2084   Full duration: 39.9092509747
2085
2086   test scenario NovaSecGroup.boot_and_delete_server_with_secgroups
2087   +-----------------------------------------------------------------------------------------------------------+
2088   |                                           Response Times (sec)                                            |
2089   +-----------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2090   | action                            | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
2091   +-----------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2092   | nova.create_10_security_groups    | 1.442  | 1.794  | 2.113  | 2.16   | 2.206  | 1.86   | 100.0%  | 10    |
2093   | nova.create_100_rules             | 8.824  | 9.984  | 10.299 | 10.317 | 10.336 | 9.856  | 100.0%  | 10    |
2094   | nova.boot_server                  | 4.38   | 5.129  | 5.811  | 5.833  | 5.855  | 5.079  | 100.0%  | 10    |
2095   | nova.get_attached_security_groups | 0.145  | 0.156  | 0.198  | 0.202  | 0.205  | 0.164  | 100.0%  | 10    |
2096   | nova.delete_server                | 2.402  | 2.436  | 4.511  | 4.525  | 4.539  | 2.875  | 100.0%  | 10    |
2097   | nova.delete_10_security_groups    | 0.768  | 0.857  | 1.079  | 1.122  | 1.165  | 0.907  | 100.0%  | 10    |
2098   | total                             | 18.735 | 20.708 | 22.726 | 22.988 | 23.251 | 20.742 | 100.0%  | 10    |
2099   +-----------------------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2100   Load duration: 60.3526058197
2101   Full duration: 85.4367339611
2102
2103   test scenario NovaServers.pause_and_unpause_server
2104   +--------------------------------------------------------------------------------------------+
2105   |                                    Response Times (sec)                                    |
2106   +---------------------+--------+--------+--------+--------+-------+--------+---------+-------+
2107   | action              | min    | median | 90%ile | 95%ile | max   | avg    | success | count |
2108   +---------------------+--------+--------+--------+--------+-------+--------+---------+-------+
2109   | nova.boot_server    | 3.714  | 5.72   | 6.358  | 6.413  | 6.467 | 5.32   | 100.0%  | 10    |
2110   | nova.pause_server   | 2.307  | 2.482  | 2.535  | 2.587  | 2.64  | 2.443  | 100.0%  | 10    |
2111   | nova.unpause_server | 2.302  | 2.363  | 2.541  | 2.584  | 2.628 | 2.415  | 100.0%  | 10    |
2112   | nova.delete_server  | 2.408  | 2.612  | 4.806  | 4.912  | 5.018 | 3.413  | 100.0%  | 10    |
2113   | total               | 10.752 | 13.334 | 16.041 | 16.05  | 16.06 | 13.592 | 100.0%  | 10    |
2114   +---------------------+--------+--------+--------+--------+-------+--------+---------+-------+
2115   Load duration: 41.5451591015
2116   Full duration: 66.7291839123
2117
2118   test scenario NovaServers.boot_server_from_volume
2119   +----------------------------------------------------------------------------------------------+
2120   |                                     Response Times (sec)                                     |
2121   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2122   | action               | min    | median | 90%ile | 95%ile | max    | avg    | success | count |
2123   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2124   | cinder.create_volume | 3.333  | 3.526  | 5.986  | 6.114  | 6.242  | 4.458  | 100.0%  | 10    |
2125   | nova.boot_server     | 8.493  | 8.945  | 11.959 | 12.295 | 12.632 | 9.727  | 100.0%  | 10    |
2126   | total                | 11.903 | 13.604 | 17.765 | 18.139 | 18.513 | 14.185 | 100.0%  | 10    |
2127   +----------------------+--------+--------+--------+--------+--------+--------+---------+-------+
2128   Load duration: 41.6071519852
2129   Full duration: 78.2099730968
2130
2131   test scenario NovaServers.boot_and_list_server
2132   +----------------------------------------------------------------------------------------+
2133   |                                  Response Times (sec)                                  |
2134   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2135   | action            | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2136   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2137   | nova.boot_server  | 3.63  | 5.537  | 6.197  | 6.233  | 6.268 | 5.191 | 100.0%  | 10    |
2138   | nova.list_servers | 0.144 | 0.215  | 0.381  | 0.418  | 0.456 | 0.252 | 100.0%  | 10    |
2139   | total             | 3.87  | 5.823  | 6.499  | 6.572  | 6.645 | 5.443 | 100.0%  | 10    |
2140   +-------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2141   Load duration: 17.032296896
2142   Full duration: 51.2773780823
2143
2144   2016-02-12 20:28:19,817 - run_rally - DEBUG - task_id : 86ea3837-f2e0-40c9-94c4-4716ca177f60
2145   2016-02-12 20:28:19,817 - run_rally - DEBUG - running command line : rally task report 86ea3837-f2e0-40c9-94c4-4716ca177f60 --out /home/opnfv/functest/results/rally/opnfv-nova.html
2146   2016-02-12 20:28:20,475 - run_rally - DEBUG - running command line : rally task results 86ea3837-f2e0-40c9-94c4-4716ca177f60
2147   2016-02-12 20:28:21,078 - run_rally - DEBUG - saving json file
2148   2016-02-12 20:28:21,083 - run_rally - DEBUG - Push result into DB
2149   2016-02-12 20:28:22,764 - run_rally - DEBUG - <Response [200]>
2150   2016-02-12 20:28:22,768 - run_rally - INFO - Test scenario: "nova" OK.
2151
2152   2016-02-12 20:28:22,769 - run_rally - INFO - Starting test scenario "quotas" ...
2153   2016-02-12 20:28:22,769 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-quotas.yaml
2154   2016-02-12 20:28:23,212 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['quotas'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
2155   2016-02-12 20:29:11,586 - run_rally - INFO -
2156    Preparing input task
2157    Task  41e42442-c6ae-405a-9194-f4fc4f499859: started
2158   Task 41e42442-c6ae-405a-9194-f4fc4f499859: finished
2159
2160   test scenario Quotas.cinder_update
2161   +-------------------------------------------------------------------------------------------+
2162   |                                   Response Times (sec)                                    |
2163   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2164   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2165   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2166   | quotas.update_quotas | 0.584 | 0.641  | 0.717  | 0.767  | 0.817 | 0.657 | 100.0%  | 10    |
2167   | total                | 0.584 | 0.641  | 0.717  | 0.767  | 0.817 | 0.657 | 100.0%  | 10    |
2168   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2169   Load duration: 1.94293808937
2170   Full duration: 8.03202700615
2171
2172   test scenario Quotas.neutron_update
2173   +-------------------------------------------------------------------------------------------+
2174   |                                   Response Times (sec)                                    |
2175   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2176   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2177   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2178   | quotas.update_quotas | 0.239 | 0.278  | 0.402  | 0.423  | 0.444 | 0.313 | 100.0%  | 10    |
2179   | total                | 0.302 | 0.342  | 0.469  | 0.493  | 0.517 | 0.379 | 100.0%  | 10    |
2180   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2181   Load duration: 0.991186857224
2182   Full duration: 6.27371191978
2183
2184   test scenario Quotas.cinder_update_and_delete
2185   +-------------------------------------------------------------------------------------------+
2186   |                                   Response Times (sec)                                    |
2187   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2188   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2189   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2190   | quotas.update_quotas | 0.579 | 0.621  | 0.709  | 0.717  | 0.725 | 0.638 | 100.0%  | 10    |
2191   | quotas.delete_quotas | 0.425 | 0.457  | 0.537  | 0.549  | 0.561 | 0.47  | 100.0%  | 10    |
2192   | total                | 1.03  | 1.105  | 1.183  | 1.193  | 1.203 | 1.108 | 100.0%  | 10    |
2193   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2194   Load duration: 3.31679296494
2195   Full duration: 9.39453291893
2196
2197   test scenario Quotas.nova_update_and_delete
2198   +-------------------------------------------------------------------------------------------+
2199   |                                   Response Times (sec)                                    |
2200   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2201   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2202   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2203   | quotas.update_quotas | 0.317 | 0.343  | 0.381  | 0.384  | 0.387 | 0.346 | 100.0%  | 8     |
2204   | quotas.delete_quotas | 0.018 | 0.02   | 0.024  | 0.024  | 0.024 | 0.021 | 75.0%   | 8     |
2205   | total                | 0.335 | 0.354  | 0.4    | 0.403  | 0.405 | 0.365 | 75.0%   | 8     |
2206   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2207   Load duration: 0.788276195526
2208   Full duration: 6.69773983955
2209
2210   test scenario Quotas.nova_update
2211   +-------------------------------------------------------------------------------------------+
2212   |                                   Response Times (sec)                                    |
2213   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2214   | action               | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2215   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2216   | quotas.update_quotas | 0.324 | 0.38   | 0.454  | 0.456  | 0.459 | 0.387 | 100.0%  | 10    |
2217   | total                | 0.324 | 0.38   | 0.454  | 0.456  | 0.459 | 0.387 | 100.0%  | 10    |
2218   +----------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2219   Load duration: 1.2254319191
2220   Full duration: 6.98697400093
2221
2222   2016-02-12 20:29:11,586 - run_rally - DEBUG - task_id : 41e42442-c6ae-405a-9194-f4fc4f499859
2223   2016-02-12 20:29:11,587 - run_rally - DEBUG - running command line : rally task report 41e42442-c6ae-405a-9194-f4fc4f499859 --out /home/opnfv/functest/results/rally/opnfv-quotas.html
2224   2016-02-12 20:29:12,197 - run_rally - DEBUG - running command line : rally task results 41e42442-c6ae-405a-9194-f4fc4f499859
2225   2016-02-12 20:29:12,775 - run_rally - DEBUG - saving json file
2226   2016-02-12 20:29:12,777 - run_rally - DEBUG - Push result into DB
2227   2016-02-12 20:29:14,148 - run_rally - DEBUG - <Response [200]>
2228   2016-02-12 20:29:14,149 - run_rally - INFO - Test scenario: "quotas" Failed.
2229
2230   2016-02-12 20:29:14,149 - run_rally - INFO - Starting test scenario "requests" ...
2231   2016-02-12 20:29:14,149 - run_rally - DEBUG - Scenario fetched from : /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/opnfv-requests.yaml
2232   2016-02-12 20:29:14,227 - run_rally - DEBUG - running command line : rally task start --abort-on-sla-failure --task /home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/task.yaml --task-args "{'floating_network': 'ext-net', 'iterations': 10, 'tmpl_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/templates', 'netid': 'daf5424b-3efa-4514-8ece-af4597ba0ad2', 'service_list': ['requests'], 'concurrency': 4, 'tenants_amount': 3, 'image_name': 'functest-img', 'glance_image_location': '/home/opnfv/functest/data/cirros-0.3.4-x86_64-disk.img', 'flavor_name': 'm1.tiny', 'smoke': False, 'users_amount': 2, 'live_migration': False, 'sup_dir': '/home/opnfv/repos/functest/testcases/VIM/OpenStack/CI/rally_cert/scenario/support'}"
2233   2016-02-12 20:29:28,298 - run_rally - INFO -
2234    Preparing input task
2235    Task  69b780f0-daca-4fbe-b9d6-45abe7cd9985: started
2236   Task 69b780f0-daca-4fbe-b9d6-45abe7cd9985: finished
2237
2238   test scenario HttpRequests.check_random_request
2239   +--------------------------------------------------------------------------------------------+
2240   |                                    Response Times (sec)                                    |
2241   +------------------------+------+--------+--------+--------+-------+-------+---------+-------+
2242   | action                 | min  | median | 90%ile | 95%ile | max   | avg   | success | count |
2243   +------------------------+------+--------+--------+--------+-------+-------+---------+-------+
2244   | requests.check_request | 0.44 | 0.577  | 1.063  | 1.074  | 1.084 | 0.694 | 100.0%  | 10    |
2245   | total                  | 0.44 | 0.577  | 1.063  | 1.074  | 1.084 | 0.694 | 100.0%  | 10    |
2246   +------------------------+------+--------+--------+--------+-------+-------+---------+-------+
2247   Load duration: 2.00274682045
2248   Full duration: 4.5990281105
2249
2250   test scenario HttpRequests.check_request
2251   +---------------------------------------------------------------------------------------------+
2252   |                                    Response Times (sec)                                     |
2253   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2254   | action                 | min   | median | 90%ile | 95%ile | max   | avg   | success | count |
2255   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2256   | requests.check_request | 0.444 | 0.46   | 0.482  | 0.483  | 0.483 | 0.464 | 100.0%  | 10    |
2257   | total                  | 0.444 | 0.46   | 0.482  | 0.483  | 0.483 | 0.464 | 100.0%  | 10    |
2258   +------------------------+-------+--------+--------+--------+-------+-------+---------+-------+
2259   Load duration: 1.41119194031
2260   Full duration: 3.8915681839
2261
2262   2016-02-12 20:29:28,298 - run_rally - DEBUG - task_id : 69b780f0-daca-4fbe-b9d6-45abe7cd9985
2263   2016-02-12 20:29:28,298 - run_rally - DEBUG - running command line : rally task report 69b780f0-daca-4fbe-b9d6-45abe7cd9985 --out /home/opnfv/functest/results/rally/opnfv-requests.html
2264   2016-02-12 20:29:28,895 - run_rally - DEBUG - running command line : rally task results 69b780f0-daca-4fbe-b9d6-45abe7cd9985
2265   2016-02-12 20:29:29,467 - run_rally - DEBUG - saving json file
2266   2016-02-12 20:29:29,468 - run_rally - DEBUG - Push result into DB
2267   2016-02-12 20:29:30,190 - run_rally - DEBUG - <Response [200]>
2268   2016-02-12 20:29:30,190 - run_rally - INFO - Test scenario: "requests" OK.
2269
2270   2016-02-12 20:29:30,191 - run_rally - INFO -
2271
2272                        Rally Summary Report
2273   +===================+============+===============+===========+
2274   | Module            | Duration   | nb. Test Run  | Success   |
2275   +===================+============+===============+===========+
2276   | authenticate      | 00:19      | 10            | 100.00%   |
2277   +-------------------+------------+---------------+-----------+
2278   | glance            | 01:26      | 7             | 100.00%   |
2279   +-------------------+------------+---------------+-----------+
2280   | cinder            | 16:46      | 50            | 100.00%   |
2281   +-------------------+------------+---------------+-----------+
2282   | heat              | 06:30      | 32            | 92.31%    |
2283   +-------------------+------------+---------------+-----------+
2284   | keystone          | 01:12      | 29            | 100.00%   |
2285   +-------------------+------------+---------------+-----------+
2286   | neutron           | 04:59      | 31            | 100.00%   |
2287   +-------------------+------------+---------------+-----------+
2288   | nova              | 25:23      | 61            | 100.00%   |
2289   +-------------------+------------+---------------+-----------+
2290   | quotas            | 00:37      | 7             | 95.00%    |
2291   +-------------------+------------+---------------+-----------+
2292   | requests          | 00:08      | 2             | 100.00%   |
2293   +-------------------+------------+---------------+-----------+
2294   +===================+============+===============+===========+
2295   | TOTAL:            | 00:57:24   | 229           | 98.59%    |
2296   +===================+============+===============+===========+
2297
2298   2016-02-12 20:29:30,191 - run_rally - DEBUG - Pushing Rally summary into DB...
2299   2016-02-12 20:29:30,860 - run_rally - DEBUG - <Response [200]>
2300   2016-02-12 20:29:30,860 - run_rally - DEBUG - Deleting image 'functest-img' with ID '0c74bd9e-0ac2-4332-8e03-e00c266752ad'...
2301   2016-02-12 20:29:31,444 - run_rally - DEBUG - Deleting volume type 'volume_test'...
2302 ::