tim_enders
Contributor
Contributor

Import of physical Win2003 server fails with "Unknown Error"

I am running a production cluster consisting of 11 ESX3 hosts. They are controlled by VI, running on a physical host of its own. VMWare Converter 3.0.1 is installed on the same host as VI.

I believe[/i] I have all of the needed firewall ports open everywhere, as I followed what is in the converter manual.

I am trying to import a physical Win2003 server to the ESX cluster. I have done this successfully one other time in the past after setting up Converter, but it was a month or so ago.

I walk through the import wizard in Converter, and I'm not picking any out of the ordinary options - the only thing nonstandard that I am trying to do is downsize one of the (non-system) drives from 50GB to 20GB, as it's only got like 6GB of stuff on it. I complete the wizard, and Converter starts running the task. After completing 2%, it fails. Here is the output from the Task Progress tab in Converter:

08:55:06 AM Step 1 : Connecting to VMware Converter Agent on mgprod.loyola.edu

08:55:06 AM Step 2 : Creating target virtual machine and importing data

08:55:11 AM Configuring parameters for the target virtual machine...

08:55:14 AM Creating target virtual machine...

08:55:45 AM ERROR: Unknown error returned by VMware Converter Agent

And here is the relevant section of the log - all the prior tasks succeed:

\[2007-07-20 08:55:06.607 'P2V' 2872 verbose] \[serialization,214] Serializing job 5

\[2007-07-20 08:55:06.607 'P2V' 808 verbose] \[task,339] Transition from None to InProgress requested

\[2007-07-20 08:55:06.607 'P2V' 808 verbose] \[task,388] Transition succeeded

\[2007-07-20 08:55:06.607 'P2V' 808 info] \[task,274] Starting execution of a Task

\[2007-07-20 08:55:06.607 'P2V' 808 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-07-20 08:55:06.607 'P2V' 2872 verbose] \[serialization,221] Archiving job to C:\Documents and Settings\Administrator\Application Data\VMware\p2v30\jobs\00000005.xml

\[2007-07-20 08:55:06.639 'App' 808 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiImportTask::task\{4}

\[2007-07-20 08:55:06.654 'App' 808 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiImportTask::task\{4}

\[2007-07-20 08:55:06.654 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:06.654 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:06.654 'App' 1040 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:06.686 'P2V' 808 verbose] \[jobManager,375] Raising event 4 for job 5

\[2007-07-20 08:55:06.686 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:06.686 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:11.826 'App' 1040 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:11.842 'P2V' 808 verbose] \[jobManager,375] Raising event 4 for job 5

\[2007-07-20 08:55:11.842 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:11.842 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:14.295 'App' 848 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:14.310 'P2V' 808 verbose] \[jobManager,375] Raising event 4 for job 5

\[2007-07-20 08:55:14.310 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:14.310 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:20.748 'App' 1616 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:20.763 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:20.763 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.732 'App' 1616 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.763 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.763 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.763 'App' 1616 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.779 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:21.779 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:42.857 'App' 1616 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:42.872 'App' 808 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:42.872 'App' 808 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{4}

\[2007-07-20 08:55:45.153 'App' 1616 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiImportTask::task\{4} completed

\[2007-07-20 08:55:45.153 'App' 1616 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{4}

\[2007-07-20 08:55:45.185 'App' 808 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiImportTask::task\{4}

\[2007-07-20 08:55:45.200 'App' 808 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiImportTask::task\{4}

\[2007-07-20 08:55:45.294 'P2V' 808 error] \[task,295] Task failed: P2VError UNKNOWN_METHOD_FAULT(sysimage.fault.FileOpenError)

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[task,339] Transition from InProgress to Failure requested

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[task,388] Transition succeeded

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[job,276] Job 5 changing state from 1 to 2

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[serialization,214] Serializing job 5

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[serialization,221] Archiving job to C:\Documents and Settings\Administrator\Application Data\VMware\p2v30\jobs\00000005.xml

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[jobManager,375] Raising event 2 for job 5

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[jobManager,375] Raising event 4 for job 5

\[2007-07-20 08:55:45.294 'P2V' 808 verbose] \[jobManager,375] Raising event 6 for job 5

\[2007-07-20 08:55:45.294 'VmdbSvc' 808 verbose] Shutting down VMDB service...

\[2007-07-20 08:55:45.294 'VmdbSvc' 808 verbose] Unregistering callback...

\[2007-07-20 08:55:45.294 'VmdbSvc' 808 verbose] ...done

If anybody's got any thoughts about this, I would really appreciate it!

-Tim

0 Kudos
4 Replies
tim_enders
Contributor
Contributor

I forgot to mention - in this line of the log:

\[2007-07-20 08:55:45.294 'P2V' 808 error] \[task,295] Task failed: P2VError UNKNOWN_METHOD_FAULT(sysimage.fault.FileOpenError)

It mentiones "FileOpenError." There is an instance of sql running on the physical box I am trying to import. Could the file open error be caused by sql? Do I need to stop sql to run this or something?

-Tim

0 Kudos
tim_enders
Contributor
Contributor

I also just looked at the log on the physical box that I am converting. Here is an excerpt:

\[??] \[2007-07-20 08:55:21.771 'App' 3104 info] \[stub,42] Started up WSA

\[??] \[2007-07-20 08:55:42.865 'App' 3104 info] \[stub,42] \[NFC ERROR] NfcNewAuthdConnectionEx: Failed to connect to peer. Error: Cannot connect to host xxx.xxx.x.xx: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond

\[#2] \[2007-07-20 08:55:42.865 'App' 3812 error] \[diskWin32,173] Opening ha-nfc://\[SATA_Disk_Pool_1] mgprodapp/mgprodapp.vmdk@xxx.xxx.x.xx:902!52 b7 74 8e 1a da 51 09-93 5e 21 9c 5b b9 1e aa failed with error2338

\[??] \[2007-07-20 08:55:42.865 'App' 3104 info] \[stub,42] NBD_ClientOpen: Couldn't connect to xxx.xxx.x.xx:902 Cannot connect to host xxx.xxx.x.xx: A connection attempt failed because the connected party did not properly respond after a period of time, or established connection failed because connected host has failed to respond

\[??] \[2007-07-20 08:55:42.865 'App' 3104 info] \[stub,42] DISKLIB-DSCPTR: : "ha-nfc://\[SATA_Disk_Pool_1] mgprodapp/mgprodapp.vmdk@xxx.xxx.x.xx:902!52 b7 74 8e 1a da 51 09-93 5e 21 9c 5b b9 1e aa" : Failed to open NBD extent.

\[#2] \[2007-07-20 08:55:42.865 'App' 2688 error] \[client,164] Rethrowing MethodFault sysimage.fault.FileOpenError:

\[??] \[2007-07-20 08:55:42.865 'App' 3104 info] \[stub,42] DISKLIB-LINK : "ha-nfc://\[SATA_Disk_Pool_1] mgprodapp/mgprodapp.vmdk@xxx.xxx.x.xx:902!52 b7 74 8e 1a da 51 09-93 5e 21 9c 5b b9 1e aa" : failed to open (NBD_ERR_NETWORK_CONNECT).

\[#2] \[2007-07-20 08:55:42.865 'App' 1416 error] \[cloneTask,228] Cloning failed!

It looks from here like the agent on the physical box that I am trying to convert is unable to communicate with the ESX host (the IPs that I xxxed out). Could this be what's doing it?

-Tim

0 Kudos
theanykey
Virtuoso
Virtuoso

1st, make sure this is converter 3.0.1 and you are hitting the physical box using a LOCAL admin (not a domain admin)

Check basic network

  • ping from source system to VC host

  • ping from VC to ESX target system

  • ping from source system to ESX target system

  • ping from ESX target system to VC host

  • ping from ESX target to source system

Check the port usage

  • telnet from source system to VC host port 902

  • telnet from source system to ESX target system port 902

  • telnet from VC to ESX server target system port 902

  • telnet from VC to source system ports 902, 445, 139

      • Note the Virtual Center or ESX server may be configured to listen on port 905. If so, check that all systems are configured consistently and that you can telnet to the appropriate ports.

Check credentials and privileges

  • Ensure that each username can login to all systems (you may want to create one admin account on all systems to simply the testing)

  • Ensure the user has permission to create a VM on the target system

  • Ensure the user has access to LUNs on the target system

  • Ensure the user has write privilege on target system storage devices

  • Verify that the user can create a new VM on each target system from VirtualCenter

Verify space requirements

  • Check available file space on all systems (Depending on your method you will either need space equal to the selected drive or to the space used on the source drive.)

  • Verify that the Target VMname does not exist on target system

  • Optionally, turn firewall off on 3.0.1 ESX servers

0 Kudos
RDuncan
Contributor
Contributor

Looks like Converter Version 3.0.1 needs port 443 between source and destination.

0 Kudos