Bug 1666238

Summary:	OpenStack provider targeted refresh is not started even if event is caught correctly
Product:	Red Hat CloudForms Management Engine	Reporter:	Ladislav Smola <lsmola>
Component:	Providers	Assignee:	Ladislav Smola <lsmola>
Status:	CLOSED CURRENTRELEASE	QA Contact:	Yadnyawalk Tale <ytale>
Severity:	high	Docs Contact:	Red Hat CloudForms Documentation <cloudforms-docs>
Priority:	high
Version:	5.10.0	CC:	bthurber, dmetzger, jfrey, jhardy, juwatts, lavenel, obarenbo, simaishi
Target Milestone:	GA
Target Release:	5.10.0
Hardware:	Unspecified
OS:	Unspecified
Whiteboard:
Fixed In Version:	5.10.0.32	Doc Type:	If docs needed, set a value
Doc Text:		Story Points:	---
Clone Of:		Environment:
Last Closed:	2019-02-12 16:51:17 UTC	Type:	Bug
Regression:	---	Mount Type:	---
Documentation:	---	CRM:
Verified Versions:		Category:	---
oVirt Team:	---	RHEL 7.3 requirements from Atomic Host:
Cloudforms Team:	Openstack	Target Upstream Version:
Embargoed:

Description Ladislav Smola 2019-01-15 10:13:21 UTC

Description of problem:

Event compute.instance.update is not causing a targeted refresh, it looks like the parser might have some bug, or the event format has changed.

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

CloudForms: 5.10.0.31.20190108221820_a0968c8

How reproducible:

Always (periodic full refresh might hide this issue)

Steps to Reproduce:

Start VM in OpenStack

Actual results:

The targeted refresh is not triggered, but log shows the event was processed.

Expected results:

The targeted refresh should be triggered.

Additional info:

Comment 4 Brett Thurber 2019-01-15 13:55:30 UTC

Associated PR:  https://github.com/ManageIQ/manageiq-content/pull/497

Comment 5 juwatts 2019-01-21 19:00:44 UTC

Verified in:
5.10.0.32.20190115185124_c957ada

OpenStack Version:
OpenStack 13

Reproduction Steps:
1) Added a OpenStack Provider to Cloudforms
2) On the OpenStack provider, created a VM. 
3) Verified a targeted refresh was triggered

compute.instance.update was verified to be handled in the logs:

[----] I, [2019-01-21T13:55:17.368923 #51045:fa0f50]  INFO -- : MIQ(ManageIQ::Providers::Openstack::CloudManager::EventCatcher::Runner#queue_event) EMS [10.8.58.137] as [admin] Caught event [compute.instance.update]
[----] I, [2019-01-21T13:55:17.381476 #51045:fa0f50]  INFO -- : MIQ(MiqQueue.put) Message id: [23434],  id: [], Zone: [default], Role: [event], Server: [], MiqTask id: [], Ident: [ems], Target id: [10], Instance id: [], Task id: [], Command: [EmsEvent.add], Timeout: [600], Priority: [100], State: [ready], Deliver On: [], Data: [], Args: [{:event_type=>"compute.instance.update", :source=>"OPENSTACK", :message=>{"cell_name"=>"", "disk_gb"=>"20", "display_name"=>"bz-verify-juwatts", "ephemeral_gb"=>"0", "host"=>"controller-0.localdomain", "instance_id"=>"ac75b000-1b66-42e4-bf8e-2f93d5bf007d", "instance_type"=>"m1.small", "instance_type_id"=>"7", "memory_mb"=>"2048", "old_state"=>"building", "project_id"=>"ec27fb6cb3bb49da92b394fe2affd211", "request_id"=>"req-7836fb88-7dd3-4cd8-9b4c-d2b25cc5df94", "resource_id"=>"ac75b000-1b66-42e4-bf8e-2f93d5bf007d", "root_gb"=>"20", "service"=>"conductor", "state"=>"building", "tenant_id"=>"ec27fb6cb3bb49da92b394fe2affd211", "user_id"=>"8f3dee0806ce4e5d96406dc384297e03", "vcpus"=>"2"}, :timestamp=>"2019-01-21T18:55:05.020225", :username=>nil, :full_data=>{:content=>{"message_id"=>"c3a10af0-ea5b-4534-bf69-a2112770b45f", "event_type"=>"compute.instance.update", "timestamp"=>"2019-01-21T18:55:05.020225", "payload"=>{"cell_name"=>"", "disk_gb"=>"20", "display_name"=>"bz-verify-juwatts", "ephemeral_gb"=>"0", "host"=>"controller-0.localdomain", "instance_id"=>"ac75b000-1b66-42e4-bf8e-2f93d5bf007d", "instance_type"=>"m1.small", "instance_type_id"=>"7", "memory_mb"=>"2048", "old_state"=>"building", "project_id"=>"ec27fb6cb3bb49da92b394fe2affd211", "request_id"=>"req-7836fb88-7dd3-4cd8-9b4c-d2b25cc5df94", "resource_id"=>"ac75b000-1b66-42e4-bf8e-2f93d5bf007d", "root_gb"=>"20", "service"=>"conductor", "state"=>"building", "tenant_id"=>"ec27fb6cb3bb49da92b394fe2affd211", "user_id"=>"8f3dee0806ce4e5d96406dc384297e03", "vcpus"=>"2"}}, :context=>{}, :user_id=>nil, :priority=>nil, :content_type=>nil}, :ems_id=>10, :vm_ems_ref=>"ac75b000-1b66-42e4-bf8e-2f93d5bf007d", :host_ems_ref=>"controller-0.localdomain"}]


This message is NO longer seen in the log:
[----] I, [2019-01-15T04:52:26.560048 #1078:123ef50]  INFO -- : Instance [/ManageIQ/System/Event/EmsEvent/OPENSTACK/compute.instance.update] not found in MiqAeDatastore - trying [.missing]

Comment 6 Yadnyawalk Tale 2019-01-22 16:47:20 UTC

Confirmed it by running migration on 5.10.0.32 and OSP 14. Migration worked with https://github.com/oVirt/ovirt-ansible-v2v-conversion-host/commit/29f5317f0b668bed413c360903940ef5a10cb297 fix.