Bug 1688465 - [v2v][RHV42] : Migration not working with RHV42
Summary: [v2v][RHV42] : Migration not working with RHV42
Keywords:
Status: CLOSED CURRENTRELEASE
Alias: None
Product: Red Hat CloudForms Management Engine
Classification: Red Hat
Component: V2V
Version: 5.10.2
Hardware: All
OS: All
high
high
Target Milestone: GA
: 5.11.0
Assignee: Fabien Dupont
QA Contact: Shveta
Red Hat CloudForms Documentation
URL:
Whiteboard: v2v
Depends On:
Blocks: 1683439 1689947
TreeView+ depends on / blocked
 
Reported: 2019-03-13 19:15 UTC by Shveta
Modified: 2019-12-13 15:09 UTC (History)
5 users (show)

Fixed In Version: 5.11.0.1
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
: 1689947 (view as bug list)
Environment:
Last Closed: 2019-12-13 15:09:47 UTC
Category: Bug
Cloudforms Team: V2V
Target Upstream Version:
Embargoed:


Attachments (Terms of Use)
Logs (543.37 KB, text/plain)
2019-03-13 19:15 UTC, Shveta
no flags Details

Description Shveta 2019-03-13 19:15:00 UTC
Created attachment 1543723 [details]
Logs

Description of problem:


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


How reproducible:


Steps to Reproduce:
1. Add rhv42 and vmware to appliance .
2. Create infra mapping
3. Create migration plan , migrate 
4. Migration plan fails 

Actual results:


Expected results:


Additional info:
Logs are attached.
Migration is working fine in 5.10.1.2
Appliance : https://10.8.198.216

Comment 2 Shveta 2019-03-13 19:22:18 UTC
[root@dhcp-8-196-184 log]# tailf automation.log | grep "ERROR" [----] E, [2019-03-13T14:40:11.158216 #5607:1711230] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) <AEMethod poweroff> The following error occurred during method evaluation:
[----] E, [2019-03-13T14:40:11.158774 #5607:1711230] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) <AEMethod poweroff>   RuntimeError: VM 'ytale-ubuntu-13march-002 is powered on, but we are not allowed to shut it down. Aborting.
[----] E, [2019-03-13T14:40:11.159685 #5607:1711230] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) <AEMethod poweroff>   /ManageIQ/Transformation/Infrastructure/VM/Common/PowerOff:16:in `main'
[----] E, [2019-03-13T14:40:11.168614 #5607:1711230] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) Method STDERR: /ManageIQ/Transformation/Infrastructure/VM/Common/PowerOff:16:in `main': VM 'ytale-ubuntu-13march-002 is powered on, but we are not allowed to shut it down. Aborting. (RuntimeError)
[----] E, [2019-03-13T14:40:11.169114 #5607:1711230] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) Method STDERR:     from /ManageIQ/Transformation/Infrastructure/VM/Common/PowerOff:36:in `<main>'
[----] E, [2019-03-13T14:40:11.197103 #5607:ecef50] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) Aborting instantiation (unknown method return code) because [Method exited with rc=Unknown RC: [1]]
[----] E, [2019-03-13T14:40:11.197540 #5607:ecef50] ERROR -- : Q-task_id([r9_service_template_transformation_plan_task_11]) State=<State5> running  raised exception: <Method exited with rc=Unknown RC: [1]>

Comment 9 Ilanit Stein 2019-03-17 11:41:12 UTC
Tested CFME-5.10.2.0/RHV-4.3.1
Did not succeed migrating a single VM.

Added this patch:
 https://patch-diff.githubusercontent.com/raw/ManageIQ/manageiq-providers-ovirt/pull/343.patch
To overcome RHV-4.3.0,4.3.1 refresh bug: https://bugzilla.redhat.com/show_bug.cgi?id=1668720, that was resolved only in RHV-4.3.2

Checked app/models/service_template_transformation_plan_task.rb content:
To verify it contains a fix for Bug 1686049 - [v2v][RHV] Migration to RHV failed, with Status: Assess Migration
 

  def calculate_network_mappings
    source.hardware.nics.select { |n| n.device_type == 'ethernet' }.collect do |nic|
      source_network = nic.lan
      destination_network = transformation_destination(source_network)
      raise "[#{source.name}] NIC #{nic.device_name} [#{source_network.name}] has no mapping." if destination_network.nil?
      {
        :source      => source_network.name,
        :destination => destination_network_ref(destination_network),
        :mac_address => nic.address,
        :ip_address  => nic.network.try(:ipaddress)
      }.compact
    end
  end


In CFME UI: After running "Migrate", the migration plan was approved, but then it begun waiting for conversion host.
automation.log show "Waiting for PreflightCheck", "message"=>"State5 is not finished yet [7/86400 retries]."



[----] I, [2019-03-17T07:25:10.631271 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) User [admin] with current group ID [2] name [EvmGroup-super_administrator]
[----] I, [2019-03-17T07:25:10.705777 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Instantiating [/Transformation/StateMachines/VMTransformation/Transformation?MiqServer%3A%3Amiq_server=1&ServiceTemplateTransformationPlanTask%3A%3Aservice_template_transformation_plan_task=5&User%3A%3Auser=1&ae_state=State5&ae_state_data=---%20%21ruby%2Fhash%3AActiveSupport%3A%3AHashWithIndifferentAccess%0Aae_state_progress%3A%20%0A&ae_state_previous=---%0A%22%2FManageIQ%2FTransformation%2FStateMachines%2FVMTransformation%2FTransformation%22%3A%0A%20%20ae_state%3A%20State5%0A%20%20ae_state_retries%3A%207%0A%20%20ae_state_started%3A%202019-03-17%2011%3A22%3A26%20UTC%0A%20%20ae_state_max_retries%3A%2086400%0A&ae_state_retries=7&ae_state_started=2019-03-17%2011%3A22%3A26%20UTC&object_name=Transformation&request=transformation_plan&service_action=Provision&vmdb_object_type=service_template_transformation_plan_task#create]
[----] I, [2019-03-17T07:25:11.125684 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [/Transformation/StateMachines/VMTransformation/Transformation?MiqServer%3A%3Amiq_server=1&ServiceTemplateTransformationPlanTask%3A%3Aservice_template_transformation_plan_task=5&User%3A%3Auser=1&ae_state=State5&ae_state_data=---%20%21ruby%2Fhash%3AActiveSupport%3A%3AHashWithIndifferentAccess%0Aae_state_progress%3A%20%0A&ae_state_previous=---%0A%22%2FManageIQ%2FTransformation%2FStateMachines%2FVMTransformation%2FTransformation%22%3A%0A%20%20ae_state%3A%20State5%0A%20%20ae_state_retries%3A%207%0A%20%20ae_state_started%3A%202019-03-17%2011%3A22%3A26%20UTC%0A%20%20ae_state_max_retries%3A%2086400%0A&ae_state_retries=7&ae_state_started=2019-03-17%2011%3A22%3A26%20UTC&object_name=Transformation&request=transformation_plan&service_action=Provision&vmdb_object_type=service_template_transformation_plan_task#create  ManageIQ/Transformation/StateMachines]
[----] I, [2019-03-17T07:25:11.451739 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) In State=[State5], invoking [on_entry] method=[/System/CommonMethods/MiqAe.WeightedUpdateStatus(weight => 1, description => "Waiting for PreflightCheck", task_message => "Pre-migration")]
[----] I, [2019-03-17T07:25:11.470741 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [system/commonmethods/miqae/weightedupdatestatus  ManageIQ/system/commonmethods]
[----] I, [2019-03-17T07:25:11.523304 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Invoking [inline] method [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus] with inputs [{"weight"=>1, "description"=>"Waiting for PreflightCheck", "task_message"=>"Pre-migration"}]
[----] I, [2019-03-17T07:25:11.526123 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus]> Starting 
[----] I, [2019-03-17T07:25:12.416939 #9539:fcebbc]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod weightedupdatestatus> State Hash: {"status"=>"active", "weight"=>1, "description"=>"Waiting for PreflightCheck", "message"=>"State5 is not finished yet [7/86400 retries].", "started_on"=>2019-03-17 11:22:27 UTC, "percent"=>0.008101851851851851, "updated_on"=>2019-03-17 11:24:52 UTC}
[----] I, [2019-03-17T07:25:12.540902 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus]> Ending
[----] I, [2019-03-17T07:25:12.541104 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Method exited with rc=MIQ_OK
[----] I, [2019-03-17T07:25:12.541724 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Processing State=[State5]
[----] I, [2019-03-17T07:25:12.542227 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Following Relationship [miqaedb:/Transformation/Common/PreflightCheck#create]
[----] I, [2019-03-17T07:25:12.567984 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [miqaedb:/Transformation/Common/PreflightCheck#create  ManageIQ/Transformation]
[----] I, [2019-03-17T07:25:12.593486 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Instance [/ManageIQ/Transformation/Common/PreflightCheck] not found in MiqAeDatastore - trying [.missing]
[----] I, [2019-03-17T07:25:12.604619 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [Transformation/Common/preflightcheck  ManageIQ/Transformation]
[----] I, [2019-03-17T07:25:12.616291 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Invoking [inline] method [/ManageIQ/Transformation/Common/PreflightCheck] with inputs [{}]
[----] I, [2019-03-17T07:25:12.622448 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [Transformation/Common/Utils  ManageIQ/Transformation]
[----] I, [2019-03-17T07:25:12.647532 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Loading embedded method /ManageIQ/Transformation/Common/Utils
[----] I, [2019-03-17T07:25:12.649752 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/Transformation/Common/PreflightCheck]> Starting 
[----] I, [2019-03-17T07:25:13.269887 #9539:aedd5c8]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod preflightcheck> PreflightCheck: task.state: active
[----] I, [2019-03-17T07:25:13.312372 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/Transformation/Common/PreflightCheck]> Ending
[----] I, [2019-03-17T07:25:13.312556 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Method exited with rc=MIQ_OK
[----] I, [2019-03-17T07:25:13.313189 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Followed  Relationship [miqaedb:/Transformation/Common/PreflightCheck#create]
[----] I, [2019-03-17T07:25:13.313341 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Processed State=[State5] with Result=[retry]
[----] I, [2019-03-17T07:25:13.313624 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) In State=[State5], invoking [on_exit] method=[/System/CommonMethods/MiqAe.WeightedUpdateStatus(weight => 1, description => "Waiting for PreflightCheck", task_message => "Pre-migration")]
[----] I, [2019-03-17T07:25:13.329015 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Updated namespace [system/commonmethods/miqae/weightedupdatestatus  ManageIQ/system/commonmethods]
[----] I, [2019-03-17T07:25:13.410412 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Invoking [inline] method [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus] with inputs [{"weight"=>1, "description"=>"Waiting for PreflightCheck", "task_message"=>"Pre-migration"}]
[----] I, [2019-03-17T07:25:13.413706 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus]> Starting 
[----] I, [2019-03-17T07:25:14.043918 #9539:a55ddb8]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod weightedupdatestatus> State Hash: {"status"=>"active", "weight"=>1, "description"=>"Waiting for PreflightCheck", "message"=>"State5 is not finished yet [8/86400 retries].", "started_on"=>2019-03-17 11:22:27 UTC, "percent"=>0.009259259259259259, "updated_on"=>2019-03-17 11:25:14 UTC}
[----] I, [2019-03-17T07:25:14.178171 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) <AEMethod [/ManageIQ/System/CommonMethods/MiqAe/WeightedUpdateStatus]> Ending
[----] I, [2019-03-17T07:25:14.178368 #9539:d7cf58]  INFO -- : Q-task_id([r5_service_template_transformation_plan_task_5]) Method exited with rc=MIQ_OK


Not sure what is failing the preflight check.
Unclear if the Bug 1686049 (VMware VM has no ip address) can be verified.

Comment 12 Yadnyawalk Tale 2019-06-14 12:47:11 UTC
Fixed! Verified on: 5.11.0.8.20190611155126_01e077e

Please note 5.11.0.8 don't have v2v-conversion-ansible package and hence migration not working with that but I have installed package manually and migration is working.
We are tracking that issue under BZ1720614.


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