Bug 1374636

Summary: openStack provider is configured in no-ssl, while uses ssl for swift endpoint, cloudForms have certificate verify failed SSLError
Product: Red Hat CloudForms Management Engine Reporter: Gellert Kis <gekis>
Component: ProvidersAssignee: Greg Blomquist <gblomqui>
Status: CLOSED NOTABUG QA Contact: Dave Johnson <dajohnso>
Severity: medium Docs Contact:
Priority: unspecified    
Version: 5.6.0CC: jfrey, jhardy, obarenbo
Target Milestone: GA   
Target Release: 5.7.0   
Hardware: Unspecified   
OS: Linux   
Whiteboard:
Fixed In Version: Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2016-09-09 14:48:17 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:

Description Gellert Kis 2016-09-09 09:32:21 UTC 
Description of problem:

openStack provider is configured in no-ssl, while uses ssl for swift endpoint, cloudForms have certificate verify failed SSLError

When openStack provider is configured in no-ssl connection with cloudForms, while uses ssl for swift ,
cloudForms give SSLError, certificate verify failed. 

////

For curiosity: 
At end of log output below there is an UniqueViolation.  raised at BZ 1373997
We believe BZ 1373997 is unrelated to this bug. 

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

5.6.1.2

How reproducible:

Reproduce issue by refresh power state on provider page. 

Steps to Reproduce:
1.
2.
3.

Actual results:

[----] D, [2016-09-06T08:36:49.552456 #24912:5e5998] DEBUG -- : <Fog> excon.response  
{:status=>200,
 :headers=>
  {"Vary"=>"X-Auth-Token",
   "Content-Type"=>"application/json",
   "Content-Length"=>"4109",
   "Date"=>"Tue, 06 Sep 2016 06:36:59 GMT"},
 :body=>
  {"access"=>
    {"token"=>
      {"issued_at"=>"2016-09-06T06:36:59.502010",
       "expires"=>"2016-09-06T10:36:59Z",
       "id"=>"1948faac754543b987694ea04d68149c",
       "tenant"=>
        {"description"=>"hostxzy GCB/GTB",
         "enabled"=>true,
         "id"=>"004c894975bc4df484cfeb1f2e2ed4ac",
         "name"=>"GCB_PRB_hostxzy_PRE"},
       "audit_ids"=>["XOnH_A4KRoKtgJDjKVVKKg"]},
     "serviceCatalog"=>
      [{"endpoints"=>
         [{"adminURL"=>
            "http://nova.XXX.cloud.corp:8774/v2/004c894975bc4df484cfeb1f2e2ed4ac",
           "region"=>"XXX",
           "internalURL"=>
            "http://nova.XXX.cloud.corp:8774/v2/004c894975bc4df484cfeb1f2e2ed4ac",
           "id"=>"2b62208175764d0bbfc7aec92e4c5268",
           "publicURL"=>
            "http://nova.XXX.cloud.corp:8774/v2/004c894975bc4df484cfeb1f2e2ed4ac"}],
        "endpoints_links"=>[],
        "type"=>"compute",
        "name"=>"compute"},
       {"endpoints"=>
         [{"adminURL"=>"http://neutron.XXX.cloud.corp:9696",
           "region"=>"XXX",
           "internalURL"=>"http://neutron.XXX.cloud.corp:9696",
           "id"=>"02cb480df1ee48dd9a3552c7c4d28033",
           "publicURL"=>"http://neutron.XXX.cloud.corp:9696"}],
        "endpoints_links"=>[],
        "type"=>"network",
        "name"=>"neutron"},
       {"endpoints"=>
         [{"adminURL"=>
            "http://cinder.XXX.cloud.corp:8776/v2/004c894975bc4df484cfeb1f2e2ed4ac",
           "region"=>"XXX",
           "internalURL"=>
            "http://cinder.XXX.cloud.corp:8776/v2/004c894975bc4df484cfeb1f2e2ed4ac",
           "id"=>"4bcc1d4dfbda4d17aec9573785c897c8",
           "publicURL"=>
            "http://cinder.XXX.cloud.corp:8776/v2/004c894975bc4df484cfeb1f2e2ed4ac"}],
        "endpoints_links"=>[],
        "type"=>"volumev2",
        "name"=>"cinderv2"},
       {"endpoints"=>
         [{"adminURL"=>"http://glance.XXX.cloud.corp:9292",
           "region"=>"XXX",
           "internalURL"=>"http://glance.XXX.cloud.corp:9292",
           "id"=>"4330ef2aca624cdca33abdc6e137841f",
           "publicURL"=>"http://glance.XXX.cloud.corp:9292"}],
        "endpoints_links"=>[],
        "type"=>"image",
        "name"=>"glance"},
       {"endpoints"=>
         [{"adminURL"=>"http://ceilometer.XXX.cloud.corp:8777",
           "region"=>"XXX",
           "internalURL"=>"http://ceilometer.XXX.cloud.corp:8777",
           "id"=>"18918aee730143a4a21d4acfad6b719d",
           "publicURL"=>"http://ceilometer.XXX.cloud.corp:8777"}],
        "endpoints_links"=>[],
        "type"=>"metering",
        "name"=>"ceilometer"},
       {"endpoints"=>
         [{"adminURL"=>"http://heat.XXX.cloud.corp:8000/v1",
           "region"=>"XXX",
           "internalURL"=>"http://heat.XXX.cloud.corp:8000/v1",
           "id"=>"65d269cf708342f1933d2aa9aa9903ae",
           "publicURL"=>"http://heat.XXX.cloud.corp:8000/v1"}],
        "endpoints_links"=>[],
        "type"=>"cloudformation",
        "name"=>"heat-cfn"},
       {"endpoints"=>
         [{"adminURL"=>
            "http://cinder.XXX.cloud.corp:8776/v1/004c894975bc4df484cfeb1f2e2ed4ac",
           "region"=>"XXX",
           "internalURL"=>
            "http://cinder.XXX.cloud.corp:8776/v1/004c894975bc4df484cfeb1f2e2ed4ac",
           "id"=>"11d7c3896d394fc7ba7a69fb4e139835",
           "publicURL"=>
            "http://cinder.XXX.cloud.corp:8776/v1/004c894975bc4df484cfeb1f2e2ed4ac"}],
        "endpoints_links"=>[],
        "type"=>"volume",
        "name"=>"cinder"},
       {"endpoints"=>
         [{"adminURL"=>
            "http://heat.XXX.cloud.corp:8004/v1/004c894975bc4df484cfeb1f2e2ed4ac",
           "region"=>"XXX",
           "internalURL"=>
            "http://heat.XXX.cloud.corp:8004/v1/004c894975bc4df484cfeb1f2e2ed4ac",
           "id"=>"c76663d11ba74675bd73a99fb458d465",
           "publicURL"=>
            "http://heat.XXX.cloud.corp:8004/v1/004c894975bc4df484cfeb1f2e2ed4ac"}],
        "endpoints_links"=>[],
        "type"=>"orchestration",
        "name"=>"heat"},
       {"endpoints"=>
         [{"adminURL"=>"https://swift.XXX.cloud.corp/swift/v1",
           "region"=>"XXX",
           "internalURL"=>"https://swift.XXX.cloud.corp/swift/v1",
           "id"=>"189ac4b0d0cd4d709d9e1c01cba11ab7",
           "publicURL"=>"https://swift.XXX.cloud.corp/swift/v1"}],
        "endpoints_links"=>[],
        "type"=>"object-store",
        "name"=>"swift"},
       {"endpoints"=>
         [{"adminURL"=>"http://keystone.XXX.cloud.corp:35357/v2.0",
           "region"=>"XXX",
           "internalURL"=>"http://keystone.XXX.cloud.corp:5000/v2.0",
           "id"=>"153dbc7dbd0d49e5bb2b966051aff6fc",
           "publicURL"=>"http://keystone.XXX.cloud.corp:5000/v2.0"}],
        "endpoints_links"=>[],
        "type"=>"identity",
        "name"=>"keystone"}],
     "user"=>
      {"username"=>"admin",
       "roles_links"=>[],
       "id"=>"admin",
       "roles"=>[{"name"=>"admin"}],
       "name"=>"admin"},
     "metadata"=>
      {"is_admin"=>0, "roles"=>["40f2115ab5fd4e0d80caa0a48c6b87d1"]}}}}

[----] D, [2016-09-06T08:36:49.553750 #24912:5e5998] DEBUG -- : <Fog> excon.request   
{:uri=>"https://swift.XXX.cloud.corp:443/swift/v1/",
 :query=>{"format"=>"json", :limit=>1000},
 :method=>"GET",
 :headers=>
  {"User-Agent"=>"fog-core/1.42.0",
   "Content-Type"=>"application/json",
   "Accept"=>"application/json",
   "X-Auth-Token"=>"1948faac754543b987694ea04d68149c",
   "Host"=>"swift.XXX.cloud.corp:443"},
 :body=>nil}

[----] E, [2016-09-06T08:36:49.605712 #24912:5e5998] ERROR -- : <Fog> excon.error     #<Excon::Error::Certificate: SSL_connect returned=1 errno=0 state=SSLv3 read server certificate B: certificate verify failed (OpenSSL::SSL::SSLError) Unable to verify certificate. This may be an issue with the remote host or with Excon. Excon has certificates bundled, but these can be customized:

            `Excon.defaults[:ssl_ca_path] = path_to_certs`
            `ENV['SSL_CERT_DIR'] = path_to_certs`
            `Excon.defaults[:ssl_ca_file] = path_to_file`
            `ENV['SSL_CERT_FILE'] = path_to_file'
            `Excon.defaults[:ssl_verify_callback] = callback`
                (see OpenSSL::SSL::SSLContext#verify_callback)
or:
            `Excon.defaults[:ssl_verify_peer] = false` (less secure).
>

[----] E, [2016-09-06T08:36:49.605856 #24912:5e5998] ERROR -- : MIQ(OpenstackHandle::StorageDelegate#handled_list) Unable to obtain collection: 'directories' in service: 'swift' using project scope: 'GCB_PRB_hostxzy_PRE' in provider: 'keystone.XXX.cloud.corp'. Message=SSL_connect returned=1 errno=0 state=SSLv3 read server certificate B: certificate verify failed (OpenSSL::SSL::SSLError) Unable to verify certificate. This may be an issue with the remote host or with Excon. Excon has certificates bundled, but these can be customized:

            `Excon.defaults[:ssl_ca_path] = path_to_certs`
            `ENV['SSL_CERT_DIR'] = path_to_certs`
            `Excon.defaults[:ssl_ca_file] = path_to_file`
            `ENV['SSL_CERT_FILE'] = path_to_file'
            `Excon.defaults[:ssl_verify_callback] = callback`
                (see OpenSSL::SSL::SSLContext#verify_callback)
or:
            `Excon.defaults[:ssl_verify_peer] = false` (less secure).

[----] E, [2016-09-06T08:36:49.605914 #24912:5e5998] ERROR -- : MIQ(OpenstackHandle::StorageDelegate#handled_list) /opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/ssl_socket.rb:120:in `connect_nonblock'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/ssl_socket.rb:120:in `initialize'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/connection.rb:404:in `new'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/connection.rb:404:in `socket'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/connection.rb:106:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/mock.rb:47:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/instrumentor.rb:22:in `block in request_call'
/var/www/miq/vmdb/lib/vmdb/loggers/fog_logger.rb:22:in `instrument'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/instrumentor.rb:21:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/base.rb:15:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/base.rb:15:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/middlewares/base.rb:15:in `request_call'
/opt/rh/cfme-gemset/gems/excon-0.51.0/lib/excon/connection.rb:250:in `request'
/opt/rh/cfme-gemset/gems/fog-core-1.42.0/lib/fog/core/connection.rb:81:in `request'
/opt/rh/cfme-gemset/gems/fog-openstack-0.1.11/lib/fog/openstack/core.rb:81:in `request'
/opt/rh/cfme-gemset/gems/fog-openstack-0.1.11/lib/fog/storage/openstack/requests/get_containers.rb:21:in `get_containers'
/opt/rh/cfme-gemset/gems/fog-openstack-0.1.11/lib/fog/storage/openstack/models/directories.rb:11:in `all'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/pagination/base.rb:18:in `public_send'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/pagination/base.rb:18:in `call_list_method'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/pagination/marker.rb:7:in `list'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/multi_tenancy/loop.rb:7:in `block in list'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:335:in `call'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:335:in `block in accessor_for_accessible_tenants'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:318:in `call'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:318:in `block in service_for_each_accessible_tenant'
/opt/rh/cfme-gemset/gems/fog-core-1.42.0/lib/fog/core/collection.rb:19:in `each'
/opt/rh/cfme-gemset/gems/fog-core-1.42.0/lib/fog/core/collection.rb:19:in `each'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:313:in `service_for_each_accessible_tenant'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handle.rb:330:in `accessor_for_accessible_tenants'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/multi_tenancy/loop.rb:8:in `list'
/var/www/miq/vmdb/gems/pending/openstack/openstack_handle/handled_list.rb:19:in `handled_list'
/var/www/miq/vmdb/app/models/manageiq/providers/openstack/refresh_parser_common/objects.rb:8:in `get_object_store'
/var/www/miq/vmdb/app/models/manageiq/providers/openstack/cloud_manager/refresh_parser.rb:67:in `ems_inv_to_hashes'
/var/www/miq/vmdb/app/models/manageiq/providers/openstack/cloud_manager/refresh_parser.rb:12:in `ems_inv_to_hashes'
/var/www/miq/vmdb/app/models/manageiq/providers/openstack/cloud_manager/refresher.rb:6:in `parse_legacy_inventory'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:117:in `block in parse_targeted_inventory'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:11:in `realtime_store'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:30:in `realtime_block'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:117:in `parse_targeted_inventory'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:82:in `block in refresh_targets_for_ems'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:11:in `realtime_store'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:30:in `realtime_block'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:81:in `refresh_targets_for_ems'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:21:in `block (2 levels) in refresh'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:11:in `realtime_store'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:30:in `realtime_block'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:21:in `block in refresh'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:11:in `each'
/var/www/miq/vmdb/app/models/ems_refresh/refreshers/ems_refresher_mixin.rb:11:in `refresh'
/var/www/miq/vmdb/app/models/manageiq/providers/base_manager/refresher.rb:10:in `refresh'
/var/www/miq/vmdb/app/models/ems_refresh.rb:76:in `block in refresh'
/var/www/miq/vmdb/app/models/ems_refresh.rb:75:in `each'
/var/www/miq/vmdb/app/models/ems_refresh.rb:75:in `refresh'
/var/www/miq/vmdb/app/models/miq_queue.rb:345:in `block in deliver'
/opt/rh/rh-ruby22/root/usr/share/ruby/timeout.rb:89:in `block in timeout'
/opt/rh/rh-ruby22/root/usr/share/ruby/timeout.rb:34:in `block in catch'
/opt/rh/rh-ruby22/root/usr/share/ruby/timeout.rb:34:in `catch'
/opt/rh/rh-ruby22/root/usr/share/ruby/timeout.rb:34:in `catch'
/opt/rh/rh-ruby22/root/usr/share/ruby/timeout.rb:104:in `timeout'
/var/www/miq/vmdb/app/models/miq_queue.rb:341:in `deliver'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:106:in `deliver_queue_message'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:134:in `deliver_message'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:152:in `block in do_work'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:146:in `loop'
/var/www/miq/vmdb/app/models/miq_queue_worker_base/runner.rb:146:in `do_work'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:334:in `block in do_work_loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:331:in `loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:331:in `do_work_loop'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:153:in `run'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:128:in `start'
/var/www/miq/vmdb/app/models/miq_worker/runner.rb:21:in `start_worker'
/var/www/miq/vmdb/app/models/miq_worker.rb:347:in `block in start'
/opt/rh/cfme-gemset/gems/nakayoshi_fork-0.0.3/lib/nakayoshi_fork.rb:24:in `fork'
/opt/rh/cfme-gemset/gems/nakayoshi_fork-0.0.3/lib/nakayoshi_fork.rb:24:in `fork'
/var/www/miq/vmdb/app/models/miq_worker.rb:345:in `start'
/var/www/miq/vmdb/app/models/miq_worker.rb:274:in `start_worker'
/var/www/miq/vmdb/app/models/mixins/per_ems_worker_mixin.rb:68:in `start_worker_for_ems'
/var/www/miq/vmdb/app/models/mixins/per_ems_worker_mixin.rb:46:in `block in sync_workers'
/var/www/miq/vmdb/app/models/mixins/per_ems_worker_mixin.rb:45:in `each'
/var/www/miq/vmdb/app/models/mixins/per_ems_worker_mixin.rb:45:in `sync_workers'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:52:in `block in sync_workers'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:50:in `each'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:50:in `sync_workers'
/var/www/miq/vmdb/app/models/miq_server/worker_management/monitor.rb:22:in `monitor_workers'
/var/www/miq/vmdb/app/models/miq_server.rb:362:in `block in monitor'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:11:in `realtime_store'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:30:in `realtime_block'
/var/www/miq/vmdb/app/models/miq_server.rb:362:in `monitor'
/var/www/miq/vmdb/app/models/miq_server.rb:382:in `block (2 levels) in monitor_loop'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:11:in `realtime_store'
/var/www/miq/vmdb/gems/pending/util/extensions/miq-benchmark.rb:30:in `realtime_block'
/var/www/miq/vmdb/app/models/miq_server.rb:382:in `block in monitor_loop'
/var/www/miq/vmdb/app/models/miq_server.rb:381:in `loop'
/var/www/miq/vmdb/app/models/miq_server.rb:381:in `monitor_loop'
/var/www/miq/vmdb/app/models/miq_server.rb:266:in `start'
/var/www/miq/vmdb/lib/workers/evm_server.rb:65:in `start'
/var/www/miq/vmdb/lib/workers/evm_server.rb:92:in `start'
/var/www/miq/vmdb/lib/workers/bin/evm_server.rb:4:in `<main>'
[----] E, [2016-09-06T08:36:49.606272 #24912:5e5998] ERROR -- : MIQ(ManageIQ::Providers::Openstack::CloudManager::Refresher#refresh) EMS: [XXX], id: [2000000000003] Refresh failed
[----] E, [2016-09-06T08:36:49.606428 #24912:5e5998] ERROR -- : [MiqException::MiqOpenstackApiRequestError]: Unable to obtain a collection: 'directories' in a service: 'swift' through  API. Please, fix your OpenStack installation and run refresh again.  Method:[rescue in block in refresh]
[----] E, [2016-09-06T08:36:49.606488 #24912:5e5998] ERROR -- : MIQ(ManageIQ::Providers::Openstack::CloudManager::Refresher#refresh) EMS: [XXX], id: [2000000000003] Unable to perform refresh for the following targets:
[----] E, [2016-09-06T08:36:49.606674 #24912:5e5998] ERROR -- : MIQ(ManageIQ::Providers::Openstack::CloudManager::Refresher#refresh)  --- ManageIQ::Providers::Openstack::CloudManager [XXX] id [2000000000003]
[----] I, [2016-09-06T08:36:49.630721 #24912:5e5998]  INFO -- : MIQ(ManageIQ::Providers::Openstack::CloudManager::Refresher#refresh) Refreshing all targets...Complete
[----] I, [2016-09-06T08:36:49.630971 #24912:5e5998]  INFO -- : MIQ(MiqQueue#delivered) Message id: [2000000011122], State: [ok], Delivered in [151.502518639] seconds
[----] D, [2016-09-06T08:36:51.408375 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#initialize) VMDB::Config.new is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.408452 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#config) VMDB::Config#config is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.416699 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#initialize) VMDB::Config.new is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.416749 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#config) VMDB::Config#config is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.418976 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#initialize) VMDB::Config.new is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.419027 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#config) VMDB::Config#config is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.420005 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#initialize) VMDB::Config.new is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.420050 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#config) VMDB::Config#config is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.420841 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#initialize) VMDB::Config.new is deprecated.  Prefer using Settings directly.
[----] D, [2016-09-06T08:36:51.420882 #14363:b52e6c] DEBUG -- : MIQ(VMDB::Config#config) VMDB::Config#config is deprecated.  Prefer using Settings directly.
[----] I, [2016-09-06T08:36:54.307024 #14301:5e5998]  INFO -- : MIQ(MiqScheduleWorker::Runner#do_work) Number of scheduled items to be processed: 8.
[----] I, [2016-09-06T08:36:54.315685 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011148],  id: [], Zone: [default], Role: [], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [Service.retirement_check], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.322269 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011149],  id: [], Zone: [default], Role: [], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [Vm.retirement_check], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.328836 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011150],  id: [], Zone: [default], Role: [], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [OrchestrationStack.retirement_check], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.334949 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011151],  id: [], Zone: [default], Role: [], Server: [8cacd10c-7351-11e6-99bb-fa163eafe633], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [MiqServer.status_update], Timeout: [600], Priority: [20], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.341637 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011152],  id: [], Zone: [default], Role: [], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [Job.check_jobs_for_timeout], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.350960 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011153],  id: [], Zone: [default], Role: [smartstate], Server: [], Ident: [generic], Target id: [], Instance id: [], Task id: [job_dispatcher], Command: [JobProxyDispatcher.dispatch], Timeout: [600], Priority: [20], State: [ready], Deliver On: [], Data: [], Args: []
[----] I, [2016-09-06T08:36:54.358594 #14301:5e5998]  INFO -- : MIQ(MiqQueue.put) Message id: [2000000011154],  id: [], Zone: [default], Role: [], Server: [8cacd10c-7351-11e6-99bb-fa163eafe633], Ident: [generic], Target id: [], Instance id: [], Task id: [], Command: [Session.check_session_timeout], Timeout: [600], Priority: [90], State: [ready], Deliver On: [], Data: [], Args: []
[----] E, [2016-09-06T08:36:54.891011 #24921:5e5998] ERROR -- : MIQ(ManageIQ::Providers::Openstack::NetworkManager::Refresher#refresh) EMS: [XXX Network Manager], id: [2000000000004] Refresh failed
[----] E, [2016-09-06T08:36:54.891205 #24921:5e5998] ERROR -- : [ActiveRecord::RecordNotUnique]: PG::UniqueViolation: ERROR:  duplicate key value violates unique constraint "index_cloud_subnets_network_ports"
DETAIL:  Key (cloud_subnet_id, network_port_id)=(2000000000246, 2000000003833) already exists.
: INSERT INTO "cloud_subnets_network_ports" ("cloud_subnet_id", "network_port_id", "address") VALUES ($1, $2, $3) RETURNING "id"  Method:[rescue in block in refresh]


Expected results:


Additional info: