Bug 1333884 - config_tempest.py raises Could not load 'zaqar_tests': arguments already parsed: cannot register CLI option
Summary: config_tempest.py raises Could not load 'zaqar_tests': arguments already pars...
Keywords:
Status: CLOSED ERRATA
Alias: None
Product: Red Hat OpenStack
Classification: Red Hat
Component: openstack-tempest
Version: 9.0 (Mitaka)
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: ga
: 9.0 (Mitaka)
Assignee: tkammer
QA Contact: tkammer
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2016-05-06 14:37 UTC by Harry Rybacki
Modified: 2016-08-11 12:19 UTC (History)
6 users (show)

Fixed In Version: openstack-tempest-10.0.0-2.b4a056dgit.el7ost
Doc Type: No Doc Update
Doc Text:
undefined
Clone Of:
Environment:
Last Closed: 2016-08-11 12:19:16 UTC
Target Upstream Version:
Embargoed:


Attachments (Terms of Use)


Links
System ID Private Priority Status Summary Last Updated
Red Hat Product Errata RHEA-2016:1597 0 normal SHIPPED_LIVE Red Hat OpenStack Platform 9 Release Candidate Advisory 2016-08-11 16:06:52 UTC

Description Harry Rybacki 2016-05-06 14:37:02 UTC
Description of problem:

Calling tools/config_tempest.sh is raising an ArgsAlreadyParsedError. Speaking with @dmellado and @tosky this has been seen in the TripleO gates before.


Version-Release number of selected component (if applicable):

Mitaka deployed via CAT[1] on CentOS7


How reproducible:
Easily

Steps to Reproduce:
1. Deploy an under/overcloud (Mitaka) using TripleO-Quickstart[2]
2. ssh into the undercloud as the stack user
3. $ source stackrc
4. $ mkdir /home/stack/tempest
5. $ cd /home/stack/tempest
6. $ /usr/share/openstack-tempest*/tools/configure-tempest-directory
8. $ tools/config_tempest.py --out etc/tempest.conf --network-id <your network uuid> --deployer-input /home/stack/tempest-deployer-input.conf --debug --create identity.uri http://192.0.2.1:5000/v2.0 identity.admin_password <your keystone password> network.tenant_network_cidr 192.168.0.0/24 object-storage.operator_role swiftoperator orchestration.stack_owner_role heat_stack_owner

Actual results:

2016-05-06 14:14:54.186 24595 INFO tempest [-] Using tempest config file /etc/tempest/tempest.conf
2016-05-06 14:14:54.389 24595 ERROR tempest.test_discover.plugins [-] Could not load 'zaqar_tests': arguments already parsed: cannot register CLI option
2016-05-06 14:14:54.389 24595 CRITICAL tempest [-] ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
2016-05-06 14:14:54.389 24595 ERROR tempest Traceback (most recent call last):
2016-05-06 14:14:54.389 24595 ERROR tempest   File "tools/config_tempest.py", line 419, in <module>
2016-05-06 14:14:54.389 24595 ERROR tempest     class TempestConf(ConfigParser.SafeConfigParser):
2016-05-06 14:14:54.389 24595 ERROR tempest   File "tools/config_tempest.py", line 427, in TempestConf
2016-05-06 14:14:54.389 24595 ERROR tempest     CONF = tempest.config.TempestConfigPrivate(parse_conf=False)
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/home/stack/tempest/tempest/config.py", line 1354, in __init__
2016-05-06 14:14:54.389 24595 ERROR tempest     register_opts()
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/home/stack/tempest/tempest/config.py", line 1240, in register_opts
2016-05-06 14:14:54.389 24595 ERROR tempest     ext_plugins = plugins.TempestTestPluginManager()
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/home/stack/tempest/tempest/lib/common/utils/misc.py", line 30, in getinstance
2016-05-06 14:14:54.389 24595 ERROR tempest     instances[cls] = cls()
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/home/stack/tempest/tempest/test_discover/plugins.py", line 77, in __init__
2016-05-06 14:14:54.389 24595 ERROR tempest     on_load_failure_callback=self.failure_hook)
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 93, in __init__
2016-05-06 14:14:54.389 24595 ERROR tempest     verify_requirements)
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 171, in _load_plugins
2016-05-06 14:14:54.389 24595 ERROR tempest     self._on_load_failure_callback(self, ep, err)
2016-05-06 14:14:54.389 24595 ERROR tempest   File "/home/stack/tempest/tempest/test_discover/plugins.py", line 82, in failure_hook
2016-05-06 14:14:54.389 24595 ERROR tempest     raise err
2016-05-06 14:14:54.389 24595 ERROR tempest ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
2016-05-06 14:14:54.389 24595 ERROR tempest 
Expected results:

1. config_tempst.sh generates a tempest.conf file and places it under tempest/etc


Additional info:

[1] - https://github.com/redhat-openstack/ci-ansible-tripleo
[2] - https://github.com/openstack/tripleo-quickstart/

tempest-deployer-input.conf contents:
[compute-feature-enabled]
console_output = false

[object-storage]
operator_role = swiftoperator

[orchestration]
stack_owner_role = heat_stack_owner

[volume]
backend1_name = tripleo_iscsi

[volume-feature-enabled]
bootable = true

[baremetal]
provision_timeout = 300
driver_enabled = True

Comment 2 Steve Linabery 2016-06-06 21:21:25 UTC
I did a tripleo-quickstack local install, and built an openstack-tempest RPM in a local dlrn instance that:
 a) removes requirements.txt from the source
 b) removed the Requires: python-zaqar-tests

After installing that, I still hit the 'Could not load 'zaqar_tests': arguments already parsed: cannot register CLI option' error.

I added some debug to the stevedore._load_plugins method, and then tried various combinations of having openstack-zaqar, python-zaqar-tests, and python-zaqarclient installed.

My test, btw, is running 'tempest --help --debug'. But I think it's hitting the same codepath as the error in this BZ.

It seems that there is something wrong with the entry_point configuration for openstack-zaqar package, because if that package is installed I reliably hit the error. Having python-zaqar-tests or python-zaqarclient installed doesn't produce it.

I followed stacktraces to the 'resolve' method of the pkg_resources.EntryPoint object, but it's doing __import__ magic method, and here I reach the bounds of my meager python knowledge.

Comment 3 Alan Pevec 2016-06-06 21:40:07 UTC
(In reply to Steve Linabery from comment #2)
> I followed stacktraces to the 'resolve' method of the
> pkg_resources.EntryPoint object, but it's doing __import__ magic method, and
> here I reach the bounds of my meager python knowledge.

Try with this patch https://review.openstack.org/300832 to get the actual code point where it breaks.

Comment 4 Steve Linabery 2016-06-06 21:51:53 UTC
I applied that patch (by hand) and still get the following stacktrace:
[root@undercloud zaqar]# tempest --help --debug
usage: tempest [--version] [-v | -q] [--log-file LOG_FILE] [-h] [--debug]

Tempest cli application

optional arguments:
  --version            show program's version number and exit
  -v, --verbose        Increase verbosity of output. Can be repeated.
  -q, --quiet          Suppress output except warnings and errors.
  --log-file LOG_FILE  Specify a file to log output. Disabled by default.
  -h, --help           Show help message and exit.
  --debug              Show tracebacks on errors.

Commands:
  account-generator  Create accounts.yaml file for concurrent test runs.
2016-06-06 21:47:54.636 26521 INFO tempest [-] Using tempest config file /etc/tempest/tempest.conf
namespace tempest.test_plugins
2016-06-06 21:47:54.687 26521 ERROR tempest.test_discover.plugins [-] Could not load 'zaqar_tests': arguments already parsed: cannot register CLI option
Could not load EntryPoint.parse('cleanup = tempest.cmd.cleanup:TempestCleanup')
Traceback (most recent call last):
  File "/usr/lib/python2.7/site-packages/cliff/help.py", line 22, in __call__
    factory = ep.load()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2229, in load
    return self.resolve()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2235, in resolve
    module = __import__(self.module_name, fromlist=['__name__'], level=0)
  File "/usr/lib/python2.7/site-packages/tempest/cmd/cleanup.py", line 59, in <module>
    from tempest import clients
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 183, in <module>
    class Manager(manager.Manager):
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 188, in Manager
    CONF.identity.disable_ssl_certificate_validation,
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1288, in __getattr__
    self._config = TempestConfigPrivate(config_path=self._path)
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1263, in __init__
    register_opts()
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1157, in register_opts
    ext_plugins = plugins.TempestTestPluginManager()
  File "/usr/lib/python2.7/site-packages/tempest/lib/common/utils/misc.py", line 30, in getinstance
    instances[cls] = cls()
  File "/usr/lib/python2.7/site-packages/tempest/test_discover/plugins.py", line 77, in __init__
    on_load_failure_callback=self.failure_hook)
  File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 93, in __init__
    verify_requirements)
  File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 172, in _load_plugins
    self._on_load_failure_callback(self, ep, err)
  File "/usr/lib/python2.7/site-packages/tempest/test_discover/plugins.py", line 82, in failure_hook
    raise err
ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
namespace cliff.formatter.completion
  complete       print bash completion command
  help           print detailed help for another command
  init           Setup a local working environment for running tempest
  list-plugins   List all tempest plugins
Could not load EntryPoint.parse('run-stress = tempest.cmd.run_stress:TempestRunStress')
Traceback (most recent call last):
  File "/usr/lib/python2.7/site-packages/cliff/help.py", line 22, in __call__
    factory = ep.load()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2229, in load
    return self.resolve()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2235, in resolve
    module = __import__(self.module_name, fromlist=['__name__'], level=0)
  File "/usr/lib/python2.7/site-packages/tempest/cmd/run_stress.py", line 32, in <module>
    from tempest.stress import driver
  File "/usr/lib/python2.7/site-packages/tempest/stress/driver.py", line 26, in <module>
    from tempest import clients
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 183, in <module>
    class Manager(manager.Manager):
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 188, in Manager
    CONF.identity.disable_ssl_certificate_validation,
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1288, in __getattr__
    self._config = TempestConfigPrivate(config_path=self._path)
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1247, in __init__
    logging.register_options(_CONF)
  File "/usr/lib/python2.7/site-packages/oslo_log/log.py", line 231, in register_options
    conf.register_cli_opts(_options.common_cli_opts)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2110, in __inner
    result = f(self, *args, **kwargs)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2294, in register_cli_opts
    self.register_cli_opt(opt, group, clear_cache=False)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2114, in __inner
    return f(self, *args, **kwargs)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2286, in register_cli_opt
    raise ArgsAlreadyParsedError("cannot register CLI option")
ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
Could not load EntryPoint.parse('verify-config = tempest.cmd.verify_tempest_config:TempestVerifyConfig')
Traceback (most recent call last):
  File "/usr/lib/python2.7/site-packages/cliff/help.py", line 22, in __call__
    factory = ep.load()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2229, in load
    return self.resolve()
  File "/usr/lib/python2.7/site-packages/pkg_resources/__init__.py", line 2235, in resolve
    module = __import__(self.module_name, fromlist=['__name__'], level=0)
  File "/usr/lib/python2.7/site-packages/tempest/cmd/verify_tempest_config.py", line 28, in <module>
    from tempest import clients
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 183, in <module>
    class Manager(manager.Manager):
  File "/usr/lib/python2.7/site-packages/tempest/clients.py", line 188, in Manager
    CONF.identity.disable_ssl_certificate_validation,
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1288, in __getattr__
    self._config = TempestConfigPrivate(config_path=self._path)
  File "/usr/lib/python2.7/site-packages/tempest/config.py", line 1247, in __init__
    logging.register_options(_CONF)
  File "/usr/lib/python2.7/site-packages/oslo_log/log.py", line 231, in register_options
    conf.register_cli_opts(_options.common_cli_opts)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2110, in __inner
    result = f(self, *args, **kwargs)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2294, in register_cli_opts
    self.register_cli_opt(opt, group, clear_cache=False)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2114, in __inner
    return f(self, *args, **kwargs)
  File "/usr/lib/python2.7/site-packages/oslo_config/cfg.py", line 2286, in register_cli_opt
    raise ArgsAlreadyParsedError("cannot register CLI option")
ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option

Comment 5 Steve Linabery 2016-06-06 21:53:20 UTC
oops, there was still one line of my debugging print statements spitting out output, e.g.:
'namespace tempest.test_plugins'

Comment 6 Alan Pevec 2016-06-07 00:24:10 UTC
I could not reproduce with packages from centos7-mitaka/current-passed-ci repo on a clean centos7 and a simple reproducer, all plugins incl. zaqar load w/o error:

# yum install openstack-tempest

import stevedore

def fail(_, ep,err):
  raise err

ext_plugins = stevedore.ExtensionManager( 'tempest.test_plugins', invoke_on_load=True, on_load_failure_callback=fail)

for e in ext_plugins.extensions:   
  print e.entry_point_target


ironic_tempest_plugin.plugin:IronicTempestPlugin
sahara.tests.tempest.scenario.data_processing.plugin:SaharaClientsScenarioPlugin
zaqar.tests.tempest_plugin.plugin:ZaqarTempestPlugin
ceilometer.tests.tempest.plugin:CeilometerTempestPlugin
aodh.tests.tempest.plugin:AodhTempestPlugin
neutron_fwaas.tests.tempest_plugin.plugin:NeutronFWaaSPlugin
mistral_tempest_tests.plugin:MistralTempestPlugin

Comment 7 Alan Pevec 2016-06-07 00:57:25 UTC
nm, above is the same as: "tempest list-plugins" and that works w/o errors!

Comment 8 Steve Linabery 2016-06-07 01:09:15 UTC
Mine was in a tripleo quickstart install. I will reinstall and see if I can reproduce.

Comment 9 Steve Linabery 2016-06-07 01:27:25 UTC
'tempest list-plugins' works without error, but 'tempest --help --debug' still errors as before. I'm doing a clean tripleo quickstart install and will attempt to reproduce the original error that started this BZ (config_tempest.py).

Comment 10 Steve Linabery 2016-06-07 01:59:00 UTC
I reproduce the original reporter's error:

[stack@undercloud tempest]$ tools/config_tempest.py --out etc/tempest.conf --network-id bd16ce15-7d14-4b5d-b38d-38c1798d846a --deployer-input /home/stack/tempest-deployer-input.conf --debug --create identity.uri http://192.0.2.1:5000/v2.0 identity.admin_password $OS_PASSWORD  network.tenant_network_cidr 192.168.0.0/24 object-storage.operator_role swiftoperator orchestration.stack_owner_role heat_stack_owner
2016-06-07 01:57:32.941 24435 INFO tempest [-] Using tempest config file /etc/tempest/tempest.conf
2016-06-07 01:57:33.061 24435 ERROR tempest.test_discover.plugins [-] Could not load 'zaqar_tests': arguments already parsed: cannot register CLI option
2016-06-07 01:57:33.062 24435 CRITICAL tempest [-] ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
2016-06-07 01:57:33.062 24435 ERROR tempest Traceback (most recent call last):
2016-06-07 01:57:33.062 24435 ERROR tempest   File "tools/config_tempest.py", line 421, in <module>
2016-06-07 01:57:33.062 24435 ERROR tempest     class TempestConf(ConfigParser.SafeConfigParser):
2016-06-07 01:57:33.062 24435 ERROR tempest   File "tools/config_tempest.py", line 429, in TempestConf
2016-06-07 01:57:33.062 24435 ERROR tempest     CONF = tempest.config.TempestConfigPrivate(parse_conf=False)
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/home/stack/tempest/tempest/config.py", line 1263, in __init__
2016-06-07 01:57:33.062 24435 ERROR tempest     register_opts()
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/home/stack/tempest/tempest/config.py", line 1157, in register_opts
2016-06-07 01:57:33.062 24435 ERROR tempest     ext_plugins = plugins.TempestTestPluginManager()
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/home/stack/tempest/tempest/lib/common/utils/misc.py", line 30, in getinstance
2016-06-07 01:57:33.062 24435 ERROR tempest     instances[cls] = cls()
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/home/stack/tempest/tempest/test_discover/plugins.py", line 77, in __init__
2016-06-07 01:57:33.062 24435 ERROR tempest     on_load_failure_callback=self.failure_hook)
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 93, in __init__
2016-06-07 01:57:33.062 24435 ERROR tempest     verify_requirements)
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/usr/lib/python2.7/site-packages/stevedore/extension.py", line 171, in _load_plugins
2016-06-07 01:57:33.062 24435 ERROR tempest     self._on_load_failure_callback(self, ep, err)
2016-06-07 01:57:33.062 24435 ERROR tempest   File "/home/stack/tempest/tempest/test_discover/plugins.py", line 82, in failure_hook
2016-06-07 01:57:33.062 24435 ERROR tempest     raise err
2016-06-07 01:57:33.062 24435 ERROR tempest ArgsAlreadyParsedError: arguments already parsed: cannot register CLI option
2016-06-07 01:57:33.062 24435 ERROR tempest

Comment 11 Alan Pevec 2016-06-07 02:07:24 UTC
> 2016-06-06 21:47:54.687 26521 ERROR tempest.test_discover.plugins [-] Could
> not load 'zaqar_tests': arguments already parsed: cannot register CLI option

CLI options for zaqar-server are registered in zaqar.bootstrap which is imported in:
  File "/usr/lib/python2.7/site-packages/zaqar/__init__.py", line 16, in <module>
    import zaqar.bootstrap

Looks like this case is hit only when using tempest CLI and with d/s config_tempest script because EmilienM reports zaqar plugin works for him in openstack/puppet CI ?

Comment 12 Alan Pevec 2016-06-07 02:11:01 UTC
Works after commenting out following lines in zaqar/bootstrap.py:

#CONF.register_cli_opts(_CLI_OPTIONS)
#log.register_options(CONF)

Comment 13 Alan Pevec 2016-06-07 10:57:22 UTC
Flavio, re. comment 11 - shouldn't those lines:
https://github.com/openstack/zaqar/blob/0a191c26c533343207c594e5a3d06df878980c8d/zaqar/bootstrap.py#L42-L46
be moved out of zaqar.bootstrap into zaqar.cmd.server ?

Comment 14 Flavio Percoco 2016-06-07 12:00:56 UTC
Yeah, I think we could do that. There was a reason to keep them there before but I don't think that's a valid reason anymore.

Comment 15 Steve Linabery 2016-06-08 18:20:20 UTC
https://review.openstack.org/#/c/327268/

Comment 17 Arx Cruz 2016-07-22 13:55:15 UTC
Tested with latest tempest package: openstack-tempest-10.0.0-2.b4a056dgit.el7ost.noarch

python tools/config_tempest.py \
 --image http://download.cirros-cloud.net/0.3.4/cirros-0.3.4-x86_64-disk.img \
 --out etc/tempest.conf \
 --debug \
 --create \
 identity.uri $OS_AUTH_URL \
 compute.allow_tenant_isolation true \
 object-storage.operator_role swiftoperator \
 identity.admin_password $OS_PASSWORD  


# ./configure-tempest.sh 
2016-07-22 09:40:23.950 3516 INFO tempest [-] Using tempest config file /usr/share/openstack-tempest-10.0.0/etc/tempest.conf
2016-07-22 09:40:24.108 3516 INFO __main__ [-] Reading defaults from file '/usr/share/openstack-tempest-10.0.0/etc/default-overrides.conf'
2016-07-22 09:40:24.109 3516 DEBUG __main__ [-] Setting [identity] uri = http://10.0.0.101:5000/v2.0 set tools/config_tempest.py:461
2016-07-22 09:40:24.109 3516 DEBUG __main__ [-] Setting [compute] allow_tenant_isolation = true set tools/config_tempest.py:461
2016-07-22 09:40:24.109 3516 DEBUG __main__ [-] Setting [object-storage] operator_role = swiftoperator set tools/config_tempest.py:461
2016-07-22 09:40:24.110 3516 DEBUG __main__ [-] Setting [identity] admin_password = GNygUzKxdeKXH6nuNvzy8GPCU set tools/config_tempest.py:461
2016-07-22 09:40:24.110 3516 DEBUG __main__ [-] Setting [identity] uri_v3 = http://10.0.0.101:5000/v3 set tools/config_tempest.py:461
2016-07-22 09:40:24.232 3516 INFO tempest.lib.common.rest_client [req-16636f47-8309-405c-9b5a-1b0c664efcaf ] Request (main): 200 POST http://10.0.0.101:5000/v2.0/tokens
2016-07-22 09:40:24.252 3516 INFO tempest.lib.common.rest_client [req-b8068122-9535-4efd-a971-a6dd33bae08c ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants 0.019s
2016-07-22 09:40:24.252 3516 DEBUG __main__ [-] Setting [identity] admin_tenant_id = 0ee6445c92c247e6880c2d1a16203a3d set tools/config_tempest.py:461
2016-07-22 09:40:25.260 3516 INFO __main__ [-] Creating user 'demo' with tenant 'demo' and password 'secrete'
2016-07-22 09:40:25.295 3516 INFO tempest.lib.common.rest_client [req-ace0c03a-eb85-4e77-9760-0a3e03272554 ] Request (main): 409 POST http://192.0.2.6:35357/v2.0/tenants 0.034s
2016-07-22 09:40:25.295 3516 INFO __main__ [-] (no change) Tenant 'demo' already exists
2016-07-22 09:40:25.315 3516 INFO tempest.lib.common.rest_client [req-437ba1cd-1fff-438a-9002-84839932f459 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants 0.020s
2016-07-22 09:40:25.350 3516 INFO tempest.lib.common.rest_client [req-ba7d86d9-e7d7-43a5-bda8-84f1b35830d6 ] Request (main): 409 POST http://192.0.2.6:35357/v2.0/users 0.035s
2016-07-22 09:40:25.351 3516 INFO __main__ [-] User 'demo' already exists. Setting password to 'secrete'
2016-07-22 09:40:25.418 3516 INFO tempest.lib.common.rest_client [req-7be14a6f-fb1c-4921-9369-3e288c8427fa ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants/837e1f822ace4825aee4490b3a9eadf1/users 0.066s
2016-07-22 09:40:25.489 3516 INFO tempest.lib.common.rest_client [req-d9abf4ae-cb30-482b-a817-1334e198883b ] Request (main): 200 PUT http://192.0.2.6:35357/v2.0/users/ea09d725f7124c3a9f4f96bab618294f/OS-KSADM/password 0.071s
2016-07-22 09:40:25.507 3516 INFO tempest.lib.common.rest_client [req-40233dc3-908a-4908-a358-5ba592448eb8 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants 0.018s
2016-07-22 09:40:25.545 3516 INFO tempest.lib.common.rest_client [req-7b17f525-76f6-4f88-bd41-7f0875b41ae7 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/users 0.037s
2016-07-22 09:40:25.562 3516 INFO tempest.lib.common.rest_client [req-6fe5bfed-25a8-4d81-bfcd-6e67b83e9ec8 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/OS-KSADM/roles 0.017s
2016-07-22 09:40:25.584 3516 INFO tempest.lib.common.rest_client [req-61b8429f-75be-4009-8180-80296455d670 ] Request (main): 409 PUT http://192.0.2.6:35357/v2.0/tenants/837e1f822ace4825aee4490b3a9eadf1/users/5273c0fd092e40938dbf828d9c0298ff/roles/OS-KSADM/939909c9d06a48929fa563179c9a0097 0.021s
2016-07-22 09:40:25.585 3516 DEBUG __main__ [-] (no change) User 'admin' already has the 'admin' role in project 'demo' give_role_to_user tools/config_tempest.py:515
2016-07-22 09:40:25.602 3516 INFO tempest.lib.common.rest_client [req-e616ae2a-4ca9-41fd-ab7b-ee6c38979cff ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants 0.017s
2016-07-22 09:40:25.642 3516 INFO tempest.lib.common.rest_client [req-7ca06429-7d63-41ef-bbbc-1524395c01c2 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/users 0.040s
2016-07-22 09:40:25.658 3516 INFO tempest.lib.common.rest_client [req-9de44a04-7679-47fd-a820-4df437d7eb8e ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/OS-KSADM/roles 0.015s
2016-07-22 09:40:25.659 3516 DEBUG __main__ [-] heat_stack_owner role not required give_role_to_user tools/config_tempest.py:506
2016-07-22 09:40:25.659 3516 INFO __main__ [-] Creating user 'alt_demo' with tenant 'alt_demo' and password 'secrete'
2016-07-22 09:40:25.691 3516 INFO tempest.lib.common.rest_client [req-0a105761-5032-42d3-b6ea-1bf57ee8cc00 ] Request (main): 409 POST http://192.0.2.6:35357/v2.0/tenants 0.032s
2016-07-22 09:40:25.692 3516 INFO __main__ [-] (no change) Tenant 'alt_demo' already exists
2016-07-22 09:40:25.708 3516 INFO tempest.lib.common.rest_client [req-0cf183c1-bdc2-4863-8c6c-669650fa2559 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants 0.016s
2016-07-22 09:40:25.740 3516 INFO tempest.lib.common.rest_client [req-64d09767-45d9-44d5-a64d-b24a71d42de9 ] Request (main): 409 POST http://192.0.2.6:35357/v2.0/users 0.031s
2016-07-22 09:40:25.740 3516 INFO __main__ [-] User 'alt_demo' already exists. Setting password to 'secrete'
2016-07-22 09:40:25.790 3516 INFO tempest.lib.common.rest_client [req-1614040a-6f62-4687-ab86-088ea77c8818 ] Request (main): 200 GET http://192.0.2.6:35357/v2.0/tenants/bbcbd7a9137b460ca1180ea302b0a6f7/users 0.049s
2016-07-22 09:40:25.861 3516 INFO tempest.lib.common.rest_client [req-68d70de8-5bc2-454c-865e-7c40d62b0ff1 ] Request (main): 200 PUT http://192.0.2.6:35357/v2.0/users/b5d15ae2dad64937bb5d846e89e79c44/OS-KSADM/password 0.071s
2016-07-22 09:40:25.888 3516 INFO tempest.lib.common.rest_client [req-8e9a3c83-dcc5-49ae-86a1-000e698b9cd6 ] Request (main): 200 GET http://10.0.0.101:8774/v2.1/0ee6445c92c247e6880c2d1a16203a3d/flavors 0.026s
2016-07-22 09:40:25.892 3516 INFO __main__ [-] (no change) Found flavor 'm1.nano'
2016-07-22 09:40:25.892 3516 DEBUG __main__ [-] Setting [compute] flavor_ref = f9e7987b-c097-4903-a937-81dc839879ad set tools/config_tempest.py:461
2016-07-22 09:40:25.917 3516 INFO tempest.lib.common.rest_client [req-977f1819-58c4-43ce-9ef1-8a6912af80a4 ] Request (main): 200 GET http://10.0.0.101:8774/v2.1/0ee6445c92c247e6880c2d1a16203a3d/flavors 0.024s
2016-07-22 09:40:25.921 3516 INFO __main__ [-] (no change) Found flavor 'm1.micro'
2016-07-22 09:40:25.921 3516 DEBUG __main__ [-] Setting [compute] flavor_ref_alt = 8f88d900-9e70-4873-a56d-2aef75019748 set tools/config_tempest.py:461
2016-07-22 09:40:26.046 3516 INFO tempest.lib.common.rest_client [req-426a409b-9314-4ea6-8d07-aaa9327de073 ] Request (main): 200 GET http://10.0.0.101:9292/v2/images 0.124s
2016-07-22 09:40:26.046 3516 INFO __main__ [-] (no change) Found image 'cirros-0.3.4-x86_64-disk.img'
2016-07-22 09:40:26.047 3516 INFO __main__ [-] Downloading image e370b6e1-c037-45f3-aed1-1ef7eb6b36fc to /usr/share/openstack-tempest-10.0.0/etc/cirros-0.3.1-x86_64-disk.img
2016-07-22 09:40:26.214 3516 INFO tempest.lib.common.rest_client [req-639e4483-35a1-4d3d-afdc-a9cb4a90e6cc ] Request (main): 200 GET http://10.0.0.101:9292/v2/images/e370b6e1-c037-45f3-aed1-1ef7eb6b36fc/file 0.167s
2016-07-22 09:40:26.215 3516 DEBUG __main__ [-] <type 'str'> _download_image tools/config_tempest.py:796
2016-07-22 09:40:26.255 3516 INFO tempest.lib.common.rest_client [req-6e23bcac-8636-4681-bf1a-b039c5fea87e ] Request (main): 200 GET http://10.0.0.101:9292/v2/images 0.032s
2016-07-22 09:40:26.255 3516 INFO __main__ [-] (no change) Found image 'cirros-0.3.4-x86_64-disk.img_alt'
2016-07-22 09:40:26.256 3516 DEBUG __main__ [-] Setting [compute] image_ref = e370b6e1-c037-45f3-aed1-1ef7eb6b36fc set tools/config_tempest.py:461
2016-07-22 09:40:26.256 3516 DEBUG __main__ [-] Setting [compute] image_ref_alt = f16df637-f99c-4854-be8e-0d278af899f0 set tools/config_tempest.py:461
2016-07-22 09:40:26.256 3516 INFO __main__ [-] Setting up network
2016-07-22 09:40:26.256 3516 DEBUG __main__ [-] Is neutron present: True main tools/config_tempest.py:171
2016-07-22 09:40:26.257 3516 INFO __main__ [-] No network supplied, trying auto discover for network
2016-07-22 09:40:26.508 3516 INFO tempest.lib.common.rest_client [req-76e080b4-64ac-4807-965c-0b75583cbb00 ] Request (main): 200 GET http://10.0.0.101:9696/v2.0/networks 0.251s
2016-07-22 09:40:26.508 3516 INFO __main__ [-] Found network, using: 91d2b372-eaac-47e5-833c-80d094c9f86d
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [network] public_network_id = 91d2b372-eaac-47e5-833c-80d094c9f86d set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] glance = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] cinder = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] swift = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] sahara = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] nova = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] neutron = True set tools/config_tempest.py:461
2016-07-22 09:40:26.509 3516 DEBUG __main__ [-] Setting [service_available] trove = False set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [service_available] ceilometer = True set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [service_available] ironic = False set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [service_available] heat = True set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [service_available] zaqar = False set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [volume-feature-enabled] api_extensions = OS-SCH-HNT,os-hosts,os-vol-tenant-attr,os-quota-sets,os-types-manage,os-volume-encryption-metadata,os-snapshot-actions,backups,os-volume-actions,os-used-limits,os-volume-type-access,consistencygroups,os-vol-host-attr,encryption,os-availability-zone,capabilities,qos-specs,cgsnapshots,os-types-extra-specs,os-snapshot-manage,os-vol-mig-status-attr,os-volume-unmanage,os-image-create,os-extended-services,os-extended-snapshot-attributes,os-snapshot-unmanage,os-vol-image-meta,os-quota-class-sets,os-volume-transfer,os-volume-manage,os-admin-actions,os-services,scheduler-stats set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [object-storage-feature-enabled] discoverable_apis = formpost,bulk_delete,tempurl,bulk_upload,ratelimit,staticweb set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [compute-feature-enabled] api_extensions = NMN,OS-DCF,OS-EXT-AZ,OS-EXT-IMG-SIZE,OS-EXT-IPS,OS-EXT-IPS-MAC,OS-EXT-SRV-ATTR,OS-EXT-STS,OS-FLV-DISABLED,OS-FLV-EXT-DATA,OS-SCH-HNT,OS-SRV-USG,os-access-ips,os-admin-actions,os-admin-password,os-agents,os-aggregates,os-assisted-volume-snapshots,os-attach-interfaces,os-availability-zone,os-baremetal-ext-status,os-baremetal-nodes,os-block-device-mapping,os-block-device-mapping-v2-boot,os-cell-capacities,os-cells,os-certificates,os-cloudpipe,os-cloudpipe-update,os-config-drive,os-console-auth-tokens,os-console-output,os-consoles,os-create-backup,os-create-server-ext,os-deferred-delete,os-evacuate,os-extended-evacuate-find-host,os-extended-floating-ips,os-extended-hypervisors,os-extended-networks,os-extended-quotas,os-extended-rescue-with-image,os-extended-services,os-extended-services-delete,os-extended-status,os-extended-volumes,os-fixed-ips,os-flavor-access,os-flavor-extra-specs,os-flavor-manage,os-flavor-rxtx,os-flavor-swap,os-floating-ip-dns,os-floating-ip-pools,os-floating-ips,os-floating-ips-bulk,os-fping,os-hide-server-addresses,os-hosts,os-hypervisor-status,os-hypervisors,os-instance-actions,os-instance_usage_audit_log,os-keypairs,os-lock-server,os-migrate-server,os-migrations,os-multiple-create,os-networks,os-networks-associate,os-pause-server,os-personality,os-preserve-ephemeral-rebuild,os-quota-class-sets,os-quota-sets,os-rescue,os-security-group-default-rules,os-security-groups,os-server-diagnostics,os-server-external-events,os-server-group-quotas,os-server-groups,os-server-list-multi-status,os-server-password,os-server-sort-keys,os-server-start-stop,os-services,os-shelve,os-simple-tenant-usage,os-suspend-server,os-tenant-networks,os-used-limits,os-used-limits-for-admin,os-user-data,os-user-quotas,os-virtual-interfaces,os-volume-attachment-update,os-volumes set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [network-feature-enabled] api_extensions = default-subnetpools,qos,network-ip-availability,network_availability_zone,auto-allocated-topology,ext-gw-mode,binding,agent,subnet_allocation,l3_agent_scheduler,tag,external-net,net-mtu,availability_zone,quotas,l3-ha,provider,multi-provider,address-scope,extraroute,timestamp_core,router,extra_dhcp_opt,dns-integration,security-group,dhcp_agent_scheduler,router_availability_zone,rbac-policies,standard-attr-description,port-security,allowed-address-pairs,dvr set tools/config_tempest.py:461
2016-07-22 09:40:26.510 3516 DEBUG __main__ [-] Setting [volume-feature-enabled] api_v1 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.511 3516 DEBUG __main__ [-] Setting [volume-feature-enabled] api_v2 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.511 3516 DEBUG __main__ [-] Setting [image-feature-enabled] api_v1 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.511 3516 DEBUG __main__ [-] Setting [image-feature-enabled] api_v2 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.511 3516 DEBUG __main__ [-] Setting [identity-feature-enabled] api_v2 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.511 3516 DEBUG __main__ [-] Setting [identity-feature-enabled] api_v3 = True set tools/config_tempest.py:461
2016-07-22 09:40:26.541 3516 DEBUG __main__ [-] Setting [service_available] horizon = True set tools/config_tempest.py:461
2016-07-22 09:40:26.541 3516 DEBUG __main__ [-] Setting [dashboard] dashboard_url = http://10.0.0.101/dashboard/ set tools/config_tempest.py:461
2016-07-22 09:40:26.541 3516 DEBUG __main__ [-] Setting [dashboard] login_url = http://10.0.0.101/dashboard/auth/login/ set tools/config_tempest.py:461
2016-07-22 09:40:26.542 3516 INFO __main__ [-] Creating configuration file /usr/share/openstack-tempest-10.0.0/etc/tempest.conf

Comment 20 errata-xmlrpc 2016-08-11 12:19:16 UTC
Since the problem described in this bug report should be
resolved in a recent advisory, it has been closed with a
resolution of ERRATA.

For information on the advisory, and where to find the updated
files, follow the link below.

If the solution does not work for you, open a new bug report.

https://rhn.redhat.com/errata/RHEA-2016-1597.html


Note You need to log in before you can comment on or make changes to this bug.