VMware Cloud Community
m_d_sella
Enthusiast
Enthusiast

Unable to import a VM from a physical machine to ESX

I am currently running a VI3 environment with 7 hosts. I am currently trying to migrate one of our physical servers into VI3. The server in question is running Windows 2000 Server. Here is what I have seen far.

1) VMware Converter is running on a Windows XP workstation.

2) The agent installs successfully on the source server. (remote install)

3) Import/conversion to a "stand-alone" format works successfully

4) Import/conversion to ESX fails at 2% with the following displayed in the "Task Progress" pane:

01:23:25 PM Step 1 : Connecting to VMware Converter Agent on SERVERNAME

01:23:25 PM Step 2 : Creating target virtual machine and importing data

01:23:34 PM Configuring parameters for the target virtual machine...

01:23:38 PM WARNING: Dropping serial ports: Maximum number of 4 serial ports has been reached. Only 4 serial ports will be migrated.

01:23:38 PM Creating target virtual machine...

01:25:22 PM ERROR: Unknown error returned by VMware Converter Agent[/i]

After investigating the log file, the following error occurs just before failure:

Task failed: P2VError UNKNOWN_METHOD_FAULT(vmodl.fault.InvalidArgument)[/i]

If anyone has any ideas on what I may be missing, the help would be much appreciated.

Thanks,

Mike

Reply
0 Kudos
24 Replies
theanykey
Virtuoso
Virtuoso

Assuming you have already rebooted your win2k machine ...

Be sure you are using the built-in local admin account and not a member of or a domain admin account

This is a generic guide and all may not apply - for instance if you are not using VirtualCenter, there is no need to test the connection between ESX and VC.

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 (use telnet to verify)

  • Converter application to remote physical machine - 445 and 139

  • Converter application to VirtualCenter Server - 443

  • Converter application to ESX Server 3.x - 443

  • Physical machine to VirtualCenter Server - 443

  • Physical machine to ESX Server 3.x - 443 and 902

\*** If you are using Converter 3.0.1 make sure you do not have a web server using port 443 while running Converter

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

m_d_sella
Enthusiast
Enthusiast

theanykey,

Thanks for the reply.

\* All pings are successful.

\* Using the local administrator ID (domain ID also works fine when migrating to a stand-alone host)

\* Telnet responds in all scenarios

\* User permissions all check out

\* Disk space is plentiful

\* VMname does not currently exist

The one question I have yet: Does the workstation/server that is running Converter need direct access to the VMFS LUNs?

Thanks,

Mike

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

for testing purposes, can you install directly to the source physical machine as the "local" administrator (not the domain admin) and if it fails again, post the entire vmware-converter#.log file

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

Tested with the local install and got the same results. Based on that, as well as the fact that I can perform a conversion to a "Stand-Alone" VM platform, I would have to think there is issue with the agent connecting to the VC/ESX environment. Here is a copy of the log file:

Log for VMware Converter Client, pid=2512, version=3.0.1, build=build-44840, option=Release, section=1

\[2007-09-04 08:47:43.812 'App' 4328 info] Current working directory: T:\Documents and Settings\administrator.FFGMF1\Desktop

\[2007-09-04 08:47:43.812 'P2V' 4328 info] \[p2vSupport,171] P2V logger created

\[2007-09-04 08:47:43.812 'App' 4328 info] Vmacore::InitSSL: doVersionCheck = true, handshakeTimeoutUs = 120000000

\[2007-09-04 08:47:43.812 'P2V' 4328 info] \[p2vSupport,177] SSL context created

\[2007-09-04 08:47:43.812 'P2V' 4328 info] \[p2vSupport,187] AppInit completed

\[2007-09-04 08:47:43.812 'P2V' 4328 verbose] \[p2vLicenseManager,69] This product Hard Expires: false

\[2007-09-04 08:47:43.906 'P2V' 4328 verbose] \[jobManager,406] Deserializing the job manager's state

\[2007-09-04 08:47:43.921 'P2V' 4328 error] \[serialization,286] Job manager state deserialization error: The system cannot find the file specified.

\[2007-09-04 08:47:43.921 'P2V' 4328 verbose] \[jobManager,496] Deserializing

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:47:43.921 'P2V' 4328 verbose] \[p2vLicenseManager,232] License job init with license file: T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2vlcns

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:47:43.921 'P2V' 1792 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[jobDeserializationTask,113] Deserializing the individual jobs from T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2v30\jobs

\[2007-09-04 08:47:43.921 'P2V' 1792 info] \[task,276] Task execution completed

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:47:43.921 'P2V' 4328 verbose] \[p2vLicenseManager,247] License job Success !

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:47:43.921 'P2V' 1792 verbose] \[jobManager,367] Raising deserialization done event (7)

\[2007-09-04 08:47:43.921 'P2V' 4328 verbose] \[jobManager,532] Setting maximum number of concurrent jobs to 1

\[2007-09-04 08:47:43.921 'P2V' 4328 verbose] \[jobManager,399] Serializing the job manager's state

\[2007-09-04 08:47:43.937 'P2V' 4328 verbose] \[p2vLicenseManager,232] License job init with license file: T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2vlcns

\[2007-09-04 08:47:43.937 'P2V' 4328 verbose] \[p2vLicenseManager,247] License job Success !

\[2007-09-04 08:47:57.203 'P2V' 4328 verbose] \[p2vLicenseManager,232] License job init with license file: T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2vlcns

\[2007-09-04 08:47:57.203 'P2V' 4328 verbose] \[p2vLicenseManager,247] License job Success !

\[2007-09-04 08:48:02.812 'P2V' 3412 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:02.812 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:02.812 'P2V' 3412 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:02.812 'ClientConnection' 3412 info] Connecting to
.\pipe\vmware-ufad-p2v30-vmdb, use SSL: true

\[2007-09-04 08:48:02.812 'ClientConnection' 3412 info] Successfully connected to
.\pipe\vmware-ufad-p2v30-vmdb

\[2007-09-04 08:48:02.828 'VmdbSvc' 3412 verbose] Connected to stream: SSL(\[class Vmacore::System::NamedPipeClientStreamWin32:027535B0])

\[2007-09-04 08:48:02.828 'BaseLibs' 1792 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/

\[2007-09-04 08:48:02.843 'ClientConnection' 3412 info] Making sure that UFAD interface has version vmware-ufad-p2v30-build-44840

\[2007-09-04 08:48:02.859 'ClientConnection' 3412 info] UFAD interface version is vmware-ufad-p2v30-build-44840

\[2007-09-04 08:48:02.859 'P2V' 3412 info] \[task,276] Task execution completed

\[2007-09-04 08:48:02.859 'P2V' 3412 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:02.859 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:02.890 'P2V' 4328 info] \[ufaSession,45] QuerySourceInfo called

\[2007-09-04 08:48:02.890 'P2V' 3412 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:02.890 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:02.890 'P2V' 3412 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:02.890 'P2V' 3412 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-09-04 08:48:02.890 'App' 3412 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.906 'App' 3412 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.906 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.906 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.921 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.937 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:02.937 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:05.406 'App' 1548 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiQuerySourceInfoTask::task\{6} completed

\[2007-09-04 08:48:05.406 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:05.421 'App' 3412 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:05.421 'App' 3412 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiQuerySourceInfoTask::task\{6}

\[2007-09-04 08:48:05.453 'P2V' 3412 info] \[task,276] Task execution completed

\[2007-09-04 08:48:05.453 'P2V' 3412 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:05.453 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:08.234 'P2V' 4328 verbose] \[p2vLicenseManager,232] License job init with license file: T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2vlcns

\[2007-09-04 08:48:08.234 'P2V' 4328 verbose] \[p2vLicenseManager,247] License job Success !

\[2007-09-04 08:48:08.234 'P2V' 4328 verbose] \[p2vLicenseManager,232] License job init with license file: T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2vlcns

\[2007-09-04 08:48:08.234 'P2V' 4328 verbose] \[p2vLicenseManager,247] License job Success !

\[2007-09-04 08:48:25.921 'P2V' 3412 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:25.921 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:25.921 'P2V' 3412 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:25.921 'GetInventory' 3412 info] Connecting to host ffgvc2 on port 443 using protocol https

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: Subject mismatch: VMware vs ffgvc2

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: The remote host certificate has these problems:

\* The host name used for the connection does not match the subject name on the host certificate

\* A certificate in the host's chain is based on an untrusted root.

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: Certificate verification is disabled, so connection will proceed despite the error

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: Subject mismatch: VMware vs ffgvc2

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: The remote host certificate has these problems:

\* The host name used for the connection does not match the subject name on the host certificate

\* A certificate in the host's chain is based on an untrusted root.

\[2007-09-04 08:48:26.109 'BaseLibs' 3412 warning] SSLVerifyCertAgainstSystemStore: Certificate verification is disabled, so connection will proceed despite the error

\[2007-09-04 08:48:26.265 'GetInventory' 3412 info] Authenticating user msella

\[2007-09-04 08:48:26.703 'GetInventory' 3412 info] Logged in!

\[2007-09-04 08:48:28.921 'P2V' 3412 info] \[task,276] Task execution completed

\[2007-09-04 08:48:28.921 'P2V' 3412 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:28.921 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:39.843 'P2V' 4328 info] \[ufaSession,60] GetTargetDiskSize called

\[2007-09-04 08:48:39.859 'P2V' 1792 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:39.859 'P2V' 1792 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:39.859 'P2V' 1792 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:39.859 'P2V' 1792 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-09-04 08:48:39.859 'App' 1792 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.875 'App' 1792 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.890 'App' 1792 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.890 'App' 1792 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.906 'App' 3412 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.921 'App' 1792 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:39.921 'App' 1792 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:41.765 'App' 3412 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiGetDiskSizesTask::task\{7} completed

\[2007-09-04 08:48:41.765 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:41.781 'App' 1792 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:41.781 'App' 1792 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiGetDiskSizesTask::task\{7}

\[2007-09-04 08:48:41.812 'P2V' 1792 info] \[task,276] Task execution completed

\[2007-09-04 08:48:41.812 'P2V' 1792 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:41.812 'P2V' 1792 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:46.093 'P2V' 4328 info] \[ufaSession,74] CheckDestAvailable called

\[2007-09-04 08:48:46.093 'P2V' 4664 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:46.093 'P2V' 4664 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:46.093 'P2V' 4664 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:46.093 'P2V' 4664 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-09-04 08:48:46.109 'App' 4664 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.125 'App' 4664 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.125 'App' 4664 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.125 'App' 4664 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.125 'App' 1792 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.140 'App' 4664 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:46.140 'App' 4664 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:48.953 'App' 1792 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiCheckDestAvailableTask::task\{8} completed

\[2007-09-04 08:48:48.953 'App' 1792 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:48.953 'App' 4664 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:48.968 'App' 4664 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiCheckDestAvailableTask::task\{8}

\[2007-09-04 08:48:49.359 'P2V' 4664 info] \[task,276] Task execution completed

\[2007-09-04 08:48:49.359 'P2V' 4664 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:49.359 'P2V' 4664 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:49.359 'P2V' 4328 info] \[ufaSession,91] CheckDestParams called

\[2007-09-04 08:48:49.359 'P2V' 4664 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:48:49.359 'P2V' 4664 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:48:49.359 'P2V' 4664 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:48:49.359 'P2V' 4664 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-09-04 08:48:49.375 'App' 4664 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.390 'App' 4664 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.390 'App' 4664 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.390 'App' 4664 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.390 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.406 'App' 4664 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:49.406 'App' 4664 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:56.687 'App' 3412 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiCheckDestParamsTask::task\{9} completed

\[2007-09-04 08:48:56.687 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:56.687 'App' 4664 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:56.703 'App' 4664 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiCheckDestParamsTask::task\{9}

\[2007-09-04 08:48:56.906 'P2V' 4664 info] \[task,276] Task execution completed

\[2007-09-04 08:48:56.906 'P2V' 4664 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:48:56.906 'P2V' 4664 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:49:11.031 'VmdbSvc' 4328 verbose] Shutting down VMDB service...

\[2007-09-04 08:49:11.031 'VmdbSvc' 4328 verbose] Unregistering callback...

\[2007-09-04 08:49:11.031 'VmdbSvc' 4328 verbose] ...done

\[2007-09-04 08:49:11.046 'P2V' 4328 verbose] \[jobManager,399] Serializing the job manager's state

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[job,276] Job 1 changing state from -1 to 0

\[2007-09-04 08:49:11.062 'P2V' 4328 info] \[jobManager,560] Adding job 1

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[serialization,214] Serializing job 1

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[serialization,221] Archiving job to T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2v30\jobs\00000001.xml

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[jobManager,375] Raising event 0 for job 1

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[jobManager,485] Starting job 1 as 1/1 running job

\[2007-09-04 08:49:11.062 'P2V' 4328 info] \[jobManager,970] Starting job 1

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[job,276] Job 1 changing state from 0 to 1

\[2007-09-04 08:49:11.062 'P2V' 2744 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[serialization,214] Serializing job 1

\[2007-09-04 08:49:11.062 'P2V' 2744 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:49:11.062 'P2V' 2744 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:49:11.062 'P2V' 4328 verbose] \[serialization,221] Archiving job to T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2v30\jobs\00000001.xml

\[2007-09-04 08:49:11.078 'P2V' 4328 verbose] \[jobManager,375] Raising event 2 for job 1

\[2007-09-04 08:49:11.078 'P2V' 2744 verbose] \[jobManager,375] Raising event 4 for job 1

\[2007-09-04 08:49:11.078 'ClientConnection' 2744 info] Connecting to
.\pipe\vmware-ufad-p2v30-vmdb, use SSL: true

\[2007-09-04 08:49:11.078 'ClientConnection' 2744 info] Successfully connected to
.\pipe\vmware-ufad-p2v30-vmdb

\[2007-09-04 08:49:11.093 'VmdbSvc' 2744 verbose] Connected to stream: SSL(\[class Vmacore::System::NamedPipeClientStreamWin32:03FB3360])

\[2007-09-04 08:49:11.093 'BaseLibs' 1548 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/

\[2007-09-04 08:49:11.093 'ClientConnection' 2744 info] Making sure that UFAD interface has version vmware-ufad-p2v30-build-44840

\[2007-09-04 08:49:11.109 'ClientConnection' 2744 info] UFAD interface version is vmware-ufad-p2v30-build-44840

\[2007-09-04 08:49:11.125 'P2V' 2744 info] \[task,276] Task execution completed

\[2007-09-04 08:49:11.125 'P2V' 2744 verbose] \[task,339] Transition from InProgress to Success requested

\[2007-09-04 08:49:11.125 'P2V' 2744 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:49:11.140 'P2V' 2744 verbose] \[jobManager,1340] UFA session created successfully

\[2007-09-04 08:49:11.140 'P2V' 2744 info] \[ufaSession,109] DoImport called

\[2007-09-04 08:49:11.140 'P2V' 3412 verbose] \[task,339] Transition from None to InProgress requested

\[2007-09-04 08:49:11.140 'P2V' 2744 verbose] \[serialization,214] Serializing job 1

\[2007-09-04 08:49:11.140 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:49:11.140 'P2V' 3412 info] \[task,274] Starting execution of a Task

\[2007-09-04 08:49:11.140 'P2V' 3412 info] \[ufaTask,191] Successfully connected to VMImporter

\[2007-09-04 08:49:11.140 'P2V' 2744 verbose] \[serialization,221] Archiving job to T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2v30\jobs\00000001.xml

\[2007-09-04 08:49:11.156 'App' 3412 verbose] \[imageProcessingTaskWrapper,109] Successfully connected to VmiImportTask::task\{10}

\[2007-09-04 08:49:11.171 'App' 3412 verbose] \[imageProcessingTaskWrapper,817] Start managed object method for task VmiImportTask::task\{10}

\[2007-09-04 08:49:11.171 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:11.171 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:11.171 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:49:11.187 'P2V' 3412 verbose] \[jobManager,375] Raising event 4 for job 1

\[2007-09-04 08:49:11.187 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:11.187 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:20.031 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:49:20.046 'P2V' 3412 verbose] \[jobManager,375] Raising event 4 for job 1

\[2007-09-04 08:49:20.046 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:20.046 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.046 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.062 'P2V' 3412 verbose] \[jobManager,375] Raising event 4 for job 1

\[2007-09-04 08:49:24.062 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.062 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.062 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.078 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:49:24.078 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:14.343 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:50:14.343 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:14.343 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.859 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.875 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.875 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.875 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.890 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:16.890 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:17.750 'App' 4664 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:50:17.765 'App' 3412 verbose] \[imageProcessingTaskWrapper,437] Waiting for updates from VmiImportTask::task\{10}

\[2007-09-04 08:50:17.765 'App' 3412 verbose] \[imageProcessingTaskWrapper,668] (Re)Start waiting for property updates from VmiImportTask::task\{10}

\[2007-09-04 08:51:01.328 'App' 1792 verbose] \[imageProcessingTaskWrapper,886] Remote task VmiImportTask::task\{10} completed

\[2007-09-04 08:51:01.328 'App' 1548 verbose] \[imageProcessingTaskWrapper,749] Got an update from VmiImportTask::task\{10}

\[2007-09-04 08:51:01.328 'App' 3412 verbose] \[imageProcessingTaskWrapper,515] Cleaning up remote task VmiImportTask::task\{10}

\[2007-09-04 08:51:01.343 'App' 3412 verbose] \[imageProcessingTaskWrapper,1201] Disposing task wrapper for task VmiImportTask::task\{10}

\[2007-09-04 08:51:01.718 'P2V' 3412 error] \[task,295] Task failed: P2VError UNKNOWN_METHOD_FAULT(vmodl.fault.InvalidArgument)

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[task,339] Transition from InProgress to Failure requested

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[task,388] Transition succeeded

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[job,276] Job 1 changing state from 1 to 2

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[serialization,214] Serializing job 1

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[serialization,221] Archiving job to T:\Documents and Settings\administrator.FFGMF1\Application Data\VMware\p2v30\jobs\00000001.xml

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[jobManager,375] Raising event 2 for job 1

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[jobManager,375] Raising event 4 for job 1

\[2007-09-04 08:51:01.718 'P2V' 3412 verbose] \[jobManager,375] Raising event 6 for job 1

\[2007-09-04 08:51:01.718 'VmdbSvc' 3412 verbose] Shutting down VMDB service...

\[2007-09-04 08:51:01.718 'VmdbSvc' 3412 verbose] Unregistering callback...

\[2007-09-04 08:51:01.734 'VmdbSvc' 3412 verbose] ...done

\[2007-09-04 08:52:24.328 'P2V' 4328 info] \[p2vSupport,202] Shutting down App

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

Also, just found another forum entry where a problem was believed to be related to Citrix servers (more specifically those on which the system drives had been remapped). This scenario was in line with the configuration on the server in question here. On my problem server the drives were remapped to T: and U:. For testing purposed I was able to borrow a server with standard drives for testing. This server imported into VC/ESX just fine. At this point I would assume that it is a bug relating to drive letters on the target server. Can anyone verify this behavior?

Thanks,

Mike

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

If this was the cause, then wouldnt this problem prevent it from being pushed out as a standalone image?

If you want to troubleshoot this further, you can try to point directly to ESX as root instead of through VirtualCenter

I did notice that you are using the user msella - Is this a renamed local administrator account?

Authenticating user msella

Can you post the agent log (not the client log) as that will deliver more verbose log info (assuming msella is in fact a local admin account on the source physical machine)

if you simply want to get this machine virtualized:

1. take your standalone virtualmachine and test to see if it works (vm-player is free, and workstation6 is 30 day free trial)

2. scp/winscp the vmdk files to your ESX vmfs volume

3. run the following command to import it:

vmkfstools –i /path/to/your/vm_oldfile.vmdk /path/to/your/vm_newfile.vmdk

4. create a new vm in ESX and when prompted for virtual disks, select to choose existing vmdk files (browse to these new ones)

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

Thank you for the follow-up. Very odd problem. I agree that this problem should also occur in the stand-alone scenario if it is solely due to the drive letters. Though, I do have to wonder if the mechanisms that the ESX import uses differ from those in the stand-alone method in respect to how the drive letters are handled.

I have tried importing directly to ESX as well with the same results. msella is a temporary account that I created for testing converter, and currently has administrative rights in VirtualCenter. This account is a basic Active Directory user with nearly zero rights other than those associated in VC. As such the account does not have rights to any servers on the network.

The agent log is considerably larger than the client log, to the point where it would seem unreasonable to post. If there are any particular sections of the file that would be of interest, I can post them.

This particular server does not need to be virtualized, as I was simply using it as a test scenario while preparing for other migrations. So, if we can locate the problem, that will be of great help as I continue planning for these migrations.

Thanks,

Mike

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

Again, if this can push out as a standalone image, I cant see a problem being the source but rather the destination or the network between the two. Do conversions from other machines to the exact same location on your ESX box work ok?

If we havnt tried already, can we install converter 3.0.1 as the "local" admin (not msella or a domain admin) and run it as the "local" admin directly to ESX?

Can we try altering the size of the partition by a few megabytes (this initializes file-by-file copy) and can we try with maintain?

What happens if we try using a cold conversion with the bootCD?

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

I tested conversion of two other servers, using the exact same credentials and imported to the exact same location in the ESX/VC environment and both worked like a charm. So it would appear that is definitely something specific to that one target server.

I have tried the local install of Converter, run as the local administrator (the log that I posted is a result of this test) and the test also failed. In my initial testing I also tried both options for partition size, also with a failed result.

I have not yet tried a conversion from a cold boot CD. Hopefully I will be able to try that later this week. I will post the results.

Thanks again for the continued follow-up.

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

ok, can you post your vmware-converter#.log file at the following location and pass me back the URL?

http://pastebot.nd.edu/perl

Reply
0 Kudos
w00ten
Contributor
Contributor

I wouldn't say it is related to the target server. I would say this is a giant bug in converter because EVERY time I try to convert an image over to ESX, whether it is a VM to ESX or a physical machine to ESX, this happens, and about 75% of the time when I do any other conversion. This appears to be universal, but intermittent. I would bet that you just got lucky on those 2 other servers. I was coming on here to ask about this, but stumbled onto this, so I'm going to watch this thread. Look on the bright side, yours fails over in 5 minutes, from what I saw in the log. Mine takes over an hour to get to that point when I convert to ESX(another issue I'm still trying to figure out). I can post my logs as well if you want. It looks petty much identical to the ones already posted.

Reply
0 Kudos
masterfabi
Contributor
Contributor

I think i saw a slide at the TSX saying that, remote server cloning directly to ESX Server requieres an Enterprise License!

1. Could anybody outthere confirm this?

2. If so, do you have the Ent. Lic or only the Starter Edtion

cheers

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

masterfabi,

You are correct. To clone to ESX you do need to have an Enterprise License for Converter, which we do have installed.

w00ten,

Just for comparison, what versons of Converter, ESX, and VC are you running?

Message was edited by:

m_d_sella

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

>> I think i saw a slide at the TSX saying that, remote server cloning directly to ESX Server requieres an Enterprise License!

If you are using a feature only available through a lic file, then that option is greyed out and unselectable. therefore not a cause to an error during conversion.

Reply
0 Kudos
michaeltsa
Contributor
Contributor

I have got nearly the same problem; I try to clone the Windows 2000 Server Standard w/ Citrix Metaframe XPe installed and got the same result. I have got the drive letter re-direction enabled.

Reply
0 Kudos
theanykey
Virtuoso
Virtuoso

Citrix uses more com ports then a VM has, try the following:

1.On the source host, open regedit.

2.Navigate to HKEY_LOCAL_MACHINE\HARDWARE\DEVICEMAP\SERIALCOMM.

3.Export the key for backup-archive-restore purposes.

4.Delete CcmPort3 through CcmPort9.

5.Retry the migration.

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

theanykey,

Based on the output of Converter (first post), it appears that the COM ports were dropped automatically during the creation of the VM in ESX, but perhaps there is a problem with that process. My schedule is pretty limited this week, but hopefully I will be able to test the Cold Boot CD and the manual COM port removal early next week.

Reply
0 Kudos
m_d_sella
Enthusiast
Enthusiast

michaeltsa,

Have you tried importing a non-citrix server yet, or a Citrix server without the remapped drives? Just curious as to whether or not you have had success with other servers.

Reply
0 Kudos
w00ten
Contributor
Contributor

I am using ESX 3.0.1 Build 32039, Converter 3.0.1 Build 44840, VC 2.0.1 Build 33643. I have looked through all the logs on all my storage, all my ESX hosts, and nothing indicated any kind of drive issues, and our switch isn't reporting a lot of dropped packets. It just fails for no apparent reason.

Reply
0 Kudos