Re: Converter v3.0.1 build 44840 - 1% progress all...

samkshah · ‎08-14-2007

All,

I am trying to convert physical server into vm - the issue is that the progress stays at 1% all the time and it looks like conversion is \*very* slow. Here are details:

\- Physical server: compaq ProLiant DL 380 G2

\- RAM: approx 2GB

\- OS: Win2k SP4

\- VMWare converter: v3.0.1 build 44840

\- Running converter locally and using "this physical machine" option to convert server into vm

\- Saving virtualized files into external usb drive attached to this server

\- Performing entire operation using remote connection with RAdmin. I don't have physical access to this server since it is located at a remote datacenter

\- Symantec AV - disabled (I can uninstall if necessary)

\- I cancelled conversion couple of times during past 5-6 days since everytime it was taking longer than expected. This is my third run and it's still going for more than 24 hours. Total physical disk size - approx 200GB, It has converted only 50GB in 24 hours

=======================================================================================================================

I tried to post complete log file, however vmware form gives me an error (I think it is because of file size.

I will still keep on trying, please let me know

if there an alternate way to post those files.

=========================================================================================================================

=========================================

List of files in destination directory: G:\ is external usb drive

===========================================

Volume in drive G is My USB Drive

Volume Serial Number is D55F-3383

Directory of G:\vm\hostname

08/13/2007 02:19p

.
08/13/2007 02:19p

..

08/13/2007 02:19p 946 hostname.vmx

08/13/2007 02:55p 2,147,221,504 hostname-f001.vmdk

08/13/2007 03:32p 2,147,221,504 hostname-f002.vmdk

08/13/2007 04:08p 2,147,221,504 hostname-f003.vmdk

08/13/2007 04:43p 2,065,368,064 hostname-f004.vmdk

08/13/2007 04:43p 485 hostname.vmdk

08/13/2007 05:19p 2,147,221,504 hostname (2)-f001.vmdk

08/13/2007 05:55p 2,147,221,504 hostname (2)-f002.vmdk

08/13/2007 06:31p 2,147,221,504 hostname (2)-f003.vmdk

08/13/2007 07:08p 2,147,221,504 hostname (2)-f004.vmdk

08/13/2007 07:44p 2,147,221,504 hostname (2)-f005.vmdk

08/13/2007 08:20p 2,147,221,504 hostname (2)-f006.vmdk

08/13/2007 08:56p 2,147,221,504 hostname (2)-f007.vmdk

08/13/2007 09:32p 2,147,221,504 hostname (2)-f008.vmdk

08/13/2007 10:09p 2,147,221,504 hostname (2)-f009.vmdk

08/13/2007 10:45p 2,147,221,504 hostname (2)-f010.vmdk

08/13/2007 11:21p 2,147,221,504 hostname (2)-f011.vmdk

08/13/2007 11:57p 2,147,221,504 hostname (2)-f012.vmdk

08/14/2007 12:34a 2,147,221,504 hostname (2)-f013.vmdk

08/14/2007 01:10a 2,147,221,504 hostname (2)-f014.vmdk

08/14/2007 01:46a 2,147,221,504 hostname (2)-f015.vmdk

08/14/2007 02:22a 2,147,221,504 hostname (2)-f016.vmdk

08/14/2007 02:58a 2,147,221,504 hostname (2)-f017.vmdk

08/14/2007 03:42a 2,147,221,504 hostname (2)-f018.vmdk

08/14/2007 04:54a 2,147,221,504 hostname (2)-f019.vmdk

08/14/2007 06:05a 2,147,221,504 hostname (2)-f020.vmdk

08/14/2007 07:16a 2,147,221,504 hostname (2)-f021.vmdk

08/14/2007 08:27a 2,147,221,504 hostname (2)-f022.vmdk

08/14/2007 08:27a 1,064,632,320 hostname (2)-f023.vmdk

29 File(s) 56,810,539,415 bytes

2 Dir(s) 442,939,441,152 bytes free

===================================================

I'd appreciate if anyone can point me in right direction.

Thanks.

samkshah · ‎08-14-2007

===========

Converter logs (Truncated):

=================

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC1: HP NC3163 Fast Ethernet NIC

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] MAC Address : "removed for security reason"

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Looking for PNP Device ID: PCI\VEN_8086&DEV_1229&SUBSYS_B1340E11&REV_08\3&267A616A&0&10

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,577] We find a match

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,631] Device Characteristic: 132

\[#2] \[2007-08-13 14:19:44.203 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,641] The component is a physical network card

\[#2] \[2007-08-13 14:19:44.296 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC2: HP NC3163 Fast Ethernet NIC

\[#2] \[2007-08-13 14:19:44.296 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC2 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC3: HP NC3134 Fast Ethernet NIC

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] MAC Address : "removed for security reason"

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Looking for PNP Device ID: PCI\VEN_8086&DEV_1229&SUBSYS_B1630E11&REV_08\4&8F2C20F&0&2018

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,577] We find a match

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,631] Device Characteristic: 132

\[#2] \[2007-08-13 14:19:44.406 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,641] The component is a physical network card

\[#2] \[2007-08-13 14:19:44.515 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC4: HP NC3134 Fast Ethernet NIC

\[#2] \[2007-08-13 14:19:44.515 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC4 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:44.625 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC5: HP NC3135 Fast Ethernet Upgrade Module

\[#2] \[2007-08-13 14:19:44.625 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC5 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC6: HP NC3135 Fast Ethernet Upgrade Module

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] MAC Address : 00:02:A5:F3:56:71

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Looking for PNP Device ID: PCI\VEN_8086&DEV_1229&SUBSYS_B1640E11&REV_08\4&8F2C20F&0&3818

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,577] We find a match

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,631] Device Characteristic: 132

\[#2] \[2007-08-13 14:19:44.734 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,641] The component is a physical network card

\[#2] \[2007-08-13 14:19:44.843 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC7: RAS Async Adapter

\[#2] \[2007-08-13 14:19:44.843 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC7 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:44.953 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC8: WAN Miniport (L2TP)

\[#2] \[2007-08-13 14:19:44.953 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC8 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC9: WAN Miniport (PPTP)

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] MAC Address : 50:50:54:50:30:30

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Looking for PNP Device ID: ROOT\MS_PPTPMINIPORT\0000

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,577] We find a match

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,631] Device Characteristic: 41

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,644] The component is marked as virtual.

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Device Enumerator: ROOT

\[#2] \[2007-08-13 14:19:45.062 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,674] It is a virtual device

\[#2] \[2007-08-13 14:19:45.171 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC10: Direct Parallel

\[#2] \[2007-08-13 14:19:45.171 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC10 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:45.281 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC11: WAN Miniport (IP)

\[#2] \[2007-08-13 14:19:45.281 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC11 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] NIC12: HP Network Teaming Virtual Miniport Driver

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] MAC Address : "removed for security reason"

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Looking for PNP Device ID: ROOT\CQ_CPQTEAMMP\0000

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,577] We find a match

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,631] Device Characteristic: 32769

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,644] The component is marked as virtual.

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,995] Device Enumerator: ROOT

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,674] It is a virtual device

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,1933] scsi controller 0 has key=1004 and ID=None

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,1933] ide controller 0 has key=200 and ID=None

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,1933] ide controller 1 has key=201 and ID=None

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 verbose] \[localVMCreator,1812] Adding a NIC with legacy backing type "bridged"

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for USBcontroller

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1933] USBcontroller controller 0 has key=1007 and ID=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for cdrom

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device cdrom has key=1000 and ID=0 CtrlKey=200

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking 😧

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2039] Setting cdrom to Autodetect

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for disk

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device disk has key=1003 and ID=0 CtrlKey=1004

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking PhysicalDrive0

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device disk has key=1005 and ID=1 CtrlKey=1004

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking PhysicalDrive1

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device disk has key=1006 and ID=2 CtrlKey=1004

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking PhysicalDrive2

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for floppy

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device floppy has key=1001 and ID=None CtrlKey=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking A:

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for ide

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1933] ide controller 0 has key=200 and ID=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1933] ide controller 1 has key=201 and ID=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for scsi

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1933] scsi controller 0 has key=1004 and ID=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2005] no backing

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1846] FixupBacking for serial

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1938] Device serial has key=1002 and ID=None CtrlKey=None

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,1961] Devicebacking COM1

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,2091] CPU info: physHost 2 VM 2

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,338] Alerts:

\[#2] \[2007-08-13 14:19:45.406 'App' 1884 info] \[localVMCreator,341] VM memory exceeds allowable physical memory on the physical Host. Setting allowed memory to match host.

\[#2] \[2007-08-13 14:19:45.484 'App' 1884 info] \[localVMCreator,462] Creating Local VM (hostname) TargetProduct PRODUCT_WS_550

\[#2] \[2007-08-13 14:19:45.484 'App' 1884 info] \[localVMCreator,1070] Target config file: G:\vm\hostname\hostname.vmx

\[#2] \[2007-08-13 14:19:45.484 'App' 1884 verbose] \[localVMCreator,1195] Got a NIC: (vim.vm.device.VirtualEthernetCard) {

\[#2] dynamicType = ,

\[#2] },

\[#2] connectable = (vim.vm.device.VirtualDevice.ConnectInfo) null,

\[#2] controllerKey = 200,

\[#2] unitNumber = 0,

\[#2] }

\[#2] \[2007-08-13 14:19:45.500 'App' 1884 info] \[localVMCreator,784] Creating Local Disks

\[#2] \[2007-08-13 14:19:45.500 'App' 1884 verbose] \[localVMCreator,890] Creating Local Disk; Disk name= G:\vm\hostname\hostname.vmdk; Mode = persistent; Is2GBSplit = Yes; preallocate space = Yes; is disk Flat = Yes; size = 8307649

\[#2] \[2007-08-13 16:43:09.546 'App' 1884 info] \[,0] DISKLIB-LINK : "G:\vm\hostname\hostname.vmdk" : creation successful.

\[#2] \[2007-08-13 16:43:11.906 'App' 1884 info] \[,0] NFC connection accept timeout: 180000 milliseconds

\[#2] \[2007-08-13 16:43:11.906 'App' 1884 info] \[,0] NFC request timeout: 180000 milliseconds

\[#2] \[2007-08-13 16:43:11.906 'App' 1884 info] \[,0] NFC read timeout: 60000 milliseconds

\[#2] \[2007-08-13 16:43:11.906 'App' 1884 info] \[,0] NFC write timeout: 600000 milliseconds

\[#2] \[2007-08-13 16:43:11.937 'App' 1884 info] \[,0] DISKLIB-DSCPTR: Opened : "hostname-f001.vmdk" 0 (0x2)

\[#2] \[2007-08-13 16:43:11.953 'App' 1884 info] \[,0] DISKLIB-DSCPTR: Opened : "hostname-f002.vmdk" 0 (0x2)

\[#2] \[2007-08-13 16:43:11.953 'App' 1884 info] \[,0] DISKLIB-DSCPTR: Opened : "hostname-f003.vmdk" 0 (0x2)

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 info] \[,0] DISKLIB-DSCPTR: Opened : "hostname-f004.vmdk" 0 (0x2)

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 info] \[,0] DISKLIB-LINK : Opened 'G:\vm\hostname\hostname.vmdk' (0x2): twoGbMaxExtentFlat, 16615298 sectors / 8113 Mb.

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 info] \[,0] DISKLIB-LIB : Opened "G:\vm\hostname\hostname.vmdk" (flags 0x2). 01ED9170

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 verbose] \[diskHandleWrapper,245] Setting DDB property virtualHWVersion to 4.

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 verbose] \[diskHandleWrapper,245] Setting DDB property toolsVersion to 0.

\[#2] \[2007-08-13 16:43:12.078 'App' 1884 verbose] \[localVMCreator,890] Creating Local Disk; Disk name= G:\vm\hostname\hostname (2).vmdk; Mode = persistent; Is2GBSplit = Yes; preallocate space = Yes; is disk Flat = Yes; size = 205094337

Tekken5fan · ‎08-14-2007

I can't quite give you an answer but it seems like your network, modem or connection is not registered or can't be identified

\[#2] \[2007-08-13 14:19:44.296 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC2 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,2005] no backing

Message was edited by:

Tekken5fan

samkshah · ‎08-14-2007

It looks like it is actually copying data, it's just that it is painfully slow. Progress still shows 1% since yesterday morning and I can see that it has copyied about 60GB out of 200GB in destination directory.

At this pace, it will take about 10 days to get it completed. I don't think it should take this long though.

Any inputs appreciated.

Thank you.

samkshah · ‎08-14-2007

Is this normal to have files to be created in this pattern?

08/13/2007 02:55p 2,147,221,504 hostname-f001.vmdk

08/13/2007 03:32p 2,147,221,504 hostname-f002.vmdk

08/13/2007 04:08p 2,147,221,504 hostname-f003.vmdk

08/13/2007 04:43p 2,065,368,064 hostname-f004.vmdk

08/13/2007 04:43p 485 hostname.vmdk

08/13/2007 05:19p 2,147,221,504 hostname (2)-f001.vmdk

08/13/2007 05:55p 2,147,221,504 hostname (2)-f002.vmdk

08/13/2007 06:31p 2,147,221,504 hostname (2)-f003.vmdk

I thought it should in this pattern:

hostname-f001.vmdk

hostname-f002.vmdk

hostname-f003.vmdk

hostname-f004.vmdk

hostname-f005.vmdk

hostname-f006.vmdk

Is this related with same issue or having above pattern is usual?

Thank you.

continuum · ‎08-14-2007

The filenames with (2) seem to come from a second attempt.

Have you cleaned up those directories after failed attempts ?

________________________________________________
Do you need support with a VMFS recovery problem ? - send a message via skype "sanbarrow"
I do not support Workstation 16 at this time ...

theanykey · ‎08-14-2007

Your logs do not end in an error - so either you truncated too much or your conversion is still running fine.

\[#2] \[2007-08-13 14:19:44.296 'App' 1884 verbose] \[NetworkAdaptersInfoEnum,462] NIC2 does not have MAC address -- discarding

\[#2] \[2007-08-13 14:19:45.390 'App' 1884 info] \[localVMCreator,2005] no backing

this just means this particular NIC is being ignored for conversion

Creating Local Disk; Disk name= G:\vm\hostname\hostname (2).vmdk; Mode = persistent; Is2GBSplit = Yes; preallocate space = Yes; is disk Flat = Yes; size = 205094337

This is why you have many files: Is 2GB chunks (preallocate)

Assuming there is no error - I would be interested to know if your USB device is bottlenecking. Is this connected as a USBv1? Maybe mount a network share over a fast short link and place the resulting VM there.

Other factors to think about is the number of files vs the size of the physical disk. resizing the disk will slow the conversion down. keep in mind your hardware is also a factor in speed.

samkshah · ‎08-16-2007

I had formatted USB drive before attempting 2nd time. I even reinstalled converter hoping that it would flush any configurations data from previous failure.

samkshah · ‎08-16-2007

Assuming there is no error - I would be interested to know if your USB device is bottlenecking. Is this connected as a USBv1? Maybe mount a network share over a fast short link and place the resulting VM there.

--> Yes, This is a very old server with USB v1. It has so far converted 130 GB out of total 200 GB in about 3 1/2 days. I really cannot stop this process at this moment, however need to convert similar machine tonight. Let me connect it to USB2.0 and see how it goes.

samkshah · ‎08-16-2007

Your logs do not end in an error - so either you truncated too much or your conversion is still running fine.

--> It looks like I can't post entire file at the same time. Here are first 400 lines. I will post rest of the file in my next message.

=================================================

Log for VMware Converter Agent, pid=1032, version=3.0.1, build=build-44840, option=Release, section=2

\[2007-08-13 14:08:38.937 'App' 1028 warning] Failed to create console writer

\[??] \[2007-08-13 14:08:38.937 'App' 1056 info] Current working directory: C:\Program Files\VMware\VMware Converter

\[??] \[2007-08-13 14:08:38.953 'ThreadPool' 1056 verbose] TaskMax=40, IoMin=1, IoMax=81

\[2007-08-13 14:08:38.968 'App' 1056 info] Trying ufa_agent

\[2007-08-13 14:08:38.968 'App' 1056 verbose] Plugin 0 path: ufa-agent.dll

\[2007-08-13 14:08:38.968 'App' 1056 verbose] Plugin 0 absolute path: C:\Program Files\VMware\VMware Converter\ufa-agent.dll

\[2007-08-13 14:08:39.125 'Ufa' 1056 info] Plugin initialized

\[2007-08-13 14:08:39.125 'App' 1056 info] Trying ufa_client

\[2007-08-13 14:08:39.140 'App' 1056 verbose] Plugin 1 path: ufa-client.dll

\[2007-08-13 14:08:39.140 'App' 1056 verbose] Plugin 1 absolute path: C:\Program Files\VMware\VMware Converter\ufa-client.dll

\[2007-08-13 14:08:41.078 'App' 1056 info] \[plugin,104] UfaClientPlugin Init

\[2007-08-13 14:08:41.078 'App' 1056 info] Trying ufa_slave

\[2007-08-13 14:08:41.078 'App' 1056 verbose] Plugin 2 path: ufa-slave.dll

\[2007-08-13 14:08:41.078 'App' 1056 verbose] Plugin 2 absolute path: C:\Program Files\VMware\VMware Converter\ufa-slave.dll

\[2007-08-13 14:08:42.625 'App' 1056 info] \[osInfoWin32,112] Microsoft Windows 2000

\[2007-08-13 14:08:42.625 'App' 1056 info] \[osInfoWin32,193] Server

\[2007-08-13 14:08:42.625 'App' 1056 info] \[osInfoWin32,269] Service Pack 4(Build 2195)

\[2007-08-13 14:08:42.625 'App' 1056 info] \[plugin,117] UfaSlavePlugin Init

\[??] \[2007-08-13 14:08:42.625 'App' 1296 info] \[stub,42] NFC connection accept timeout: 180000 milliseconds

\[2007-08-13 14:08:42.625 'App' 1056 info] Trying ufa_sysMigration

\[??] \[2007-08-13 14:08:42.625 'App' 1296 info] \[stub,42] NFC request timeout: 180000 milliseconds

\[2007-08-13 14:08:42.625 'App' 1056 verbose] Plugin 3 path: ufa-sysMigration.dll

\[??] \[2007-08-13 14:08:42.625 'App' 1296 info] \[stub,42] NFC read timeout: 60000 milliseconds

\[2007-08-13 14:08:42.625 'App' 1056 verbose] Plugin 3 absolute path: C:\Program Files\VMware\VMware Converter\ufa-sysMigration.dll

\[??] \[2007-08-13 14:08:42.625 'App' 1296 info] \[stub,42] NFC write timeout: 600000 milliseconds

\[2007-08-13 14:08:44.046 'App' 1056 info] \[,0] NFC connection accept timeout: 180000 milliseconds

\[2007-08-13 14:08:44.046 'App' 1056 info] \[,0] NFC request timeout: 180000 milliseconds

\[2007-08-13 14:08:44.046 'App' 1056 info] \[,0] NFC read timeout: 60000 milliseconds

\[2007-08-13 14:08:44.046 'App' 1056 info] \[,0] NFC write timeout: 600000 milliseconds

\[2007-08-13 14:08:44.046 'App' 1056 info] \[plugin,166] SysMigrationPlugin Init

\[2007-08-13 14:08:44.046 'App' 1056 info] Trying ufa_sysReconfig

\[2007-08-13 14:08:44.046 'App' 1056 verbose] Plugin 4 path: ufa-sysReconfig.dll

\[2007-08-13 14:08:44.046 'App' 1056 verbose] Plugin 4 absolute path: C:\Program Files\VMware\VMware Converter\ufa-sysReconfig.dll

\[2007-08-13 14:08:45.281 'App' 1056 info] \[plugin,102] SysReconfigPlugin Init

\[2007-08-13 14:08:45.468 'App' 1056 info] \[utils,126] Using temp dir C:\WINNT\TEMP\vmware-temp\vmware-SYSTEM\sysReconfig

\[2007-08-13 14:08:45.859 'SysCommandWin32' 1056 verbose] Starting process: C:\Program Files\VMware\VMware Converter\unzip.exe

\[2007-08-13 14:08:46.062 'App' 1056 verbose] \[rdsXmlLoader,153] Loading reconfiguration data store XML from C:\WINNT\TEMP\vmware-temp\vmware-SYSTEM\sysReconfig\reconfigurationDataStore.xml ...

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,207] Populating ReconfigurationDataStore ...

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action LsiLogic

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_1000&dev_0030 patch: C_SYMMPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\symmpi patch: S_SYMMPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\drivers\symmpi.sys source: BASEOS sourceFileName: symmpi.sys

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action BuslogicMylex

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: enum\root\LEGACY_BUSLOGIC patch: L_BUSLOGIC

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: services\buslogic patch: S_BUSLOGIC

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\drivers\buslogic.sys source: VMWARE_DRIVERS_CAB sourceFileName: buslogic_for_nt.sys

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Buslogic_vmscsi

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_104b&dev_1040 patch: C_VMSCSI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\Class\{4D36E97B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMSCSI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\vmscsi patch: S_VMSCSI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\drivers\vmscsi.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmscsi.sys

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Buslogic_vmscsi_ACPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\3&61aaa01&0&80 patch: E_VMSCSI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Buslogic_vmscsi_NotACPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\2&ebb567f&0&80 patch: E_VMSCSI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Mouse_Keyboard_Common

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0303 patch: C_PS2KBD

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\Class\{4D36E96B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2KBD

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0f13 patch: C_PS2MOUSE

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0f03 patch: C_PS2MOUSE

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\Class\{4D36E96F-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2MOUSE

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_8086&dev_7110&cc_0601 patch: C_ISAPNP

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Mouse_Keyboard_ACPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\ACPI\PNP0303 patch: E_PS2KBD

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\ACPI\PNP0F13 patch: E_PS2MOUSE

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\ACPI\PNP0F03 patch: E_PS2MOUSE

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Mouse_Keyboard_NotACPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\*PNP0F13 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\*PNP0F03 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action NT_SVGA_Registry_Updates

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: enum\root\LEGACY_VMX_SVGA patch: E_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Common_SVGA_Updates

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Control\Class\{4D36E968-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: INF\vmx_svga.inf source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.inf

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\vmx_fb.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_fb.dll

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\vmx_mode.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_mode.dll

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\drivers\vmx_svga.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.sys

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action SVGA_Registry_Updates_APCI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\3&61aaa01&0&78 patch: E_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action SVGA_Registry_Updates_NotACPI

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\2&ebb567f&0&78 patch: E_VMX_SVGA

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Restore_i8042_NT5

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\i8042prt patch: SKUNKWORKS_S_I8042

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,418] File Update filePathInWinDir: system32\drivers\i8042prt.sys source: BASEOS sourceFileName: i8042prt.sys

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_vpcsrvc

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\1-driver-vpcsrvc patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\1-vpcsrvc patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\LEGACY_1-DRIVER-VPCSRVC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\LEGACY_1-VPCSRVC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_mrxvpc

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\MrxVPC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_MRXVPC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_vpcmap

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\VPCMap patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPCMAP patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_vpc-s3_NT4

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPC-S3 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_vpc-s3_NT5

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\PCI\VEN_5333&DEV_8811&SUBSYS_00000000&REV_00\3&267a616a&0&40 patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\s3legacy patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_vmsrvc

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\1-driver-vmsrvc patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-DRIVER-VMSRVC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\1-vmsrvc patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-VMSRVC patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_netfin

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_NETFIN patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\NetFin patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_cpqdmi

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQDMI patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\CPQDMI patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_cpqalert

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQALERT patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\CPQALERT patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.078 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\EventLog\System\CPQALERT patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action Deref_cpqagent

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\EventLog\System\Snmp patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,368] Registry Update currentControlSetKey: Services\Snmp patch: SKUNKWORKS_FILLER

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action RemoveUnwantedKeys

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,282] Loading action FixSetupLog

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,459] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
ntoskrnl.exe.*\.exe value:
system32
ntoskrnl.exe = "ntoskrnl.exe

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,459] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
hal.dll.*\.dll value:
system32
hal.dll = "hal.dll

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWin2k364Bit

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWinXP64Bit

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWin64Bit

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition NotWin64Bit

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWin2k3

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWinXP

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWin2k

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GenericWinNT4

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition NotWinNT4

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition MultiProc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition InstallSVGA

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition MustUpdateCoreNTFiles

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition GuestOsIncludesLsiLogicDriver

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition BuslogicMylex

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,493] Loading expression definition Buslogic_vmscsi

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration FixSetupLog

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action FixSetupLog

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration BuslogicMylex

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action BuslogicMylex

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration LsiLogic

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action LsiLogic

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Buslogic_vmscsi_ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Buslogic_vmscsi

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Buslogic_vmscsi_ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Buslogic_vmscsi_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Buslogic_vmscsi

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Buslogic_vmscsi_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Mouse_Keyboard_ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Mouse_Keyboard_Common

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Mouse_Keyboard_ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Mouse_Keyboard_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Mouse_Keyboard_Common

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Mouse_Keyboard_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration SVGA_NT

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Common_SVGA_Updates

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action NT_SVGA_Registry_Updates

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration SVGA_notNT_ACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Common_SVGA_Updates

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action SVGA_Registry_Updates_APCI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration SVGA_notNT_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Common_SVGA_Updates

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action SVGA_Registry_Updates_NotACPI

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Restore_i8042_NT5

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Restore_i8042_NT5

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_vpcsrvc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_vpcsrvc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_mrxvpc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_mrxvpc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_vpcmap

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_vpcmap

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_vpc-s3_NT4

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_vpc-s3_NT4

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_vpc-s3_NT5

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_vpc-s3_NT5

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_vmsrvc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_vmsrvc

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_netfin

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_netfin

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_cpqdmi

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_cpqdmi

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_cpqalert

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_cpqalert

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration Deref_cpqagent

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action Deref_cpqagent

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1055] Loading reconfiguration RemoveUnwantedKeys

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1123] Loading reconfiguration action RemoveUnwantedKeys

\[2007-08-13 14:08:46.093 'App' 1056 verbose] \[rdsXmlLoader,1177] Loading hotfixes for WINDOWS4.0

\[2007-08-13 14:08:46.093 'App' 1056 info] \[utils,153] Cleaning up temp directory C:\WINNT\TEMP\vmware-temp\vmware-SYSTEM\sysReconfig ...

\[2007-08-13 14:08:46.109 'App' 1056 info] Trying ufa_vmImporter

\[2007-08-13 14:08:46.109 'App' 1056 verbose] Plugin 5 path: ufa-vmImporter.dll

\[2007-08-13 14:08:46.109 'App' 1056 verbose] Plugin 5 absolute path: C:\Program Files\VMware\VMware Converter\ufa-vmImporter.dll

\[2007-08-13 14:08:47.062 'App' 1056 info] \[plugin,111] VMImporterPlugin Init

\[2007-08-13 14:08:47.062 'Ufa' 1056 info] Initializing SSL context

\[2007-08-13 14:08:47.062 'App' 1056 info] Vmacore::InitSSL: doVersionCheck = true, handshakeTimeoutUs = 120000000

\[2007-08-13 14:08:47.109 'Ufa' 1056 info] VMDB pipe name:
.\pipe\vmware-ufad-p2v30-vmdb, use SSL: true

\[2007-08-13 14:08:47.140 'VmdbAdapter' 1056 info] Using new VMDB VMOMI serialization format

\[2007-08-13 14:08:47.156 'Ufa' 1056 info] Plugin started

\[2007-08-13 14:08:47.156 'App' 1056 info] \[plugin,119] UfaClientPlugin Start

\[2007-08-13 14:08:47.156 'App' 1056 info] \[plugin,132] UfaSlavePlugin Start

\[2007-08-13 14:08:47.156 'App' 1056 info] \[plugin,182] SysMigrationPlugin Start

\[2007-08-13 14:08:47.156 'App' 1056 info] \[plugin,119] SysReconfigPlugin Start

\[2007-08-13 14:08:47.156 'App' 1056 info] \[plugin,126] VMImporterPlugin Start

\[2007-08-13 14:08:47.156 'App' 1056 info] \[serviceWin32,418] ufad-p2v service started

\[#1] \[2007-08-13 14:15:59.375 'App' 1056 info] Impersonating user coreteam in session 8F54DDD3-D0ED-46E7-9C33-664EDEF0F478

\[#1] \[2007-08-13 14:15:59.718 'App' 1056 info] \[vmImporter,140] Entering UFAD at QuerySourceInfo

\[#1] \[2007-08-13 14:15:59.718 'App' 1056 verbose] \[vmImporter,141] source:

\[#1] (sysimage.LiveSourceComputerSpec) {

\[#1] dynamicType = ,

\[#1] host = "",

\[#1] port = 0,

\[#1] }

\[#1] \[2007-08-13 14:15:59.718 'App' 1056 verbose] \[ufaConnection,94] Creating local adapter...

\[#1] \[2007-08-13 14:15:59.718 'App' 1056 verbose] \[disposable,69] Registering disposable session object id=VmiQuerySourceInfoTask::task\{0}

\[#1] \[2007-08-13 14:15:59.718 'App' 1056 verbose] \[disposable,80] Associating disposable session object id=VmiQuerySourceInfoTask::task\{0} with session id=8F54DDD3-D0ED-46E7-9C33-664EDEF0F478

\[#1] \[2007-08-13 14:15:59.750 'App' 1880 verbose] \[imageProcessingTaskImpl,504] VmiQuerySourceInfoTask::task\{0}: Starting execution of an image processing task

\[#1] \[2007-08-13 14:15:59.750 'App' 1880 verbose] \[imageProcessingTaskImpl,154] VmiQuerySourceInfoTask::task\{0}: SetState to running

\[#1] \[2007-08-13 14:15:59.750 'App' 1880 info] \[vmiQuerySourceInfoTask,75] VmiQuerySourceInfoTask initialized

\[#1] \[2007-08-13 14:15:59.750 'App' 1880 verbose] \[ufaConnection,94] Creating local adapter...

\[#1] \[2007-08-13 14:15:59.750 'App' 1880 warning] \[importSource,319] Unable to determine the guest OS from metadata: no metadata for sources of this type

\[#1] \[2007-08-13 14:15:59.750 'App' 1056 verbose] \[slaveConnection,189] Creating local connection to the co-located slave

\[#1] \[2007-08-13 14:15:59.750 'App' 1872 verbose] \[attachedDiskWin32,150] QueryDosDevice: ret=0 size=1024 err=122

\[#1] \[2007-08-13 14:15:59.750 'App' 1872 verbose] \[attachedDiskWin32,150] QueryDosDevice: ret=0 size=2048 err=122

\[#1] \[2007-08-13 14:15:59.750 'App' 1872 verbose] \[attachedDiskWin32,150] QueryDosDevice: ret=0 size=4096 err=122

\[#1] \[2007-08-13 14:15:59.750 'App' 1872 verbose] \[attachedDiskWin32,150] QueryDosDevice: ret=4412 size=8192 err=0

\[#1] \[2007-08-13 14:15:59.812 'App' 1872 verbose] \[disposable,69] Registering disposable session object id=computer=\{2202622998d91b89190c31c8980df6baba3cfd5d}

\[#1] \[2007-08-13 14:15:59.812 'App' 1872 verbose] \[disposable,80] Associating disposable session object id=computer=\{2202622998d91b89190c31c8980df6baba3cfd5d} with session id=8F54DDD3-D0ED-46E7-9C33-664EDEF0F478

\[??] \[2007-08-13 14:15:59.812 'App' 1296 info] \[stub,42] HostDeviceInfo: Failed to enumerate host parallel ports via the registry. Could not open device map parallel port registry key.

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{fc4f6f8a-5e24-11d6-a3f7-806d6172696f}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{6de9cd94-5852-11d8-9bb5-806d6172696f}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{6de9cd9a-5852-11d8-9bb5-0008023e3c8b}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{34e7057a-edf4-11d5-8d3f-806d6172696f}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{0e149234-5d28-11d6-b6e0-806d6172696f}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,464] Found volume with name "
?\Volume\{0780ecba-4776-11dc-8c7f-0008023e3c8b}\"

\[#1] \[2007-08-13 14:15:59.828 'App' 1872 verbose] \[attachedComputerWin32,325] Found candidate of type 18 on disk 0 at sector 32.

\[#1] \[2007-08-13 14:15:59.843 'App' 1872 verbose] \[attachedComputerWin32,367] Accounted for candidate on disk 0 at sector 32

\[??] \[2007-08-13 14:16:00.218 'App' 1296 info] \[stub,42] Info\[Windisk_GetVolumeDeviceNumber]: IOCTL_GET_STORAGE_DEVICE_NUMBER for volume
?\Volume\{6de9cd94-5852-11d8-9bb5-806d6172696f}\ is not supported .... Trying NT method.

\[??] \[2007-08-13 14:16:00.218 'App' 1296 info] \[stub,42] Error\[Windisk_GetVolumeDeviceNumber]:Failed to get
?\Volume\{6de9cd94-5852-11d8-9bb5-806d6172696f}\ Volume's disk number

\[??] \[2007-08-13 14:16:00.468 'App' 1296 info] \[stub,42] Info\[Windisk_GetVolumePartitionInfo]:Number of disk extents is 2. Volume
?\Volume\{6de9cd9a-5852-11d8-9bb5-0008023e3c8b}\ is a dynamic volume. No meaningful partition information can be associated with it

\[#1] \[2007-08-13 14:16:00.468 'App' 1872 info] \[attachedComputerWin32,162] \[GetVolumeInfo] Cannot get
?\Volume\{6de9cd9a-5852-11d8-9bb5-0008023e3c8b}\ volume's legacy partition info. The partition number is 36868705

\[??] \[2007-08-13 14:16:00.468 'App' 1296 info] \[stub,42] Info\[Windisk_GetVolumeDeviceNumber]: IOCTL_GET_STORAGE_DEVICE_NUMBER for volume
?\Volume\{6de9cd9a-5852-11d8-9bb5-0008023e3c8b}\ is not supported .... Trying NT method.

\[??] \[2007-08-13 14:16:00.468 'App' 1296 info] \[stub,42] Error\[Windisk_GetVolumeDeviceNumber]:Failed to get
?\Volume\{6de9cd9a-5852-11d8-9bb5-0008023e3c8b}\ Volume's disk number

\[#1] \[2007-08-13 14:16:00.500 'App' 1872 warning] \[attachedComputerWin32,579] \[GetVolumesForComputer] Windisk_GetVolumeDiskExtents failed with error 1

\[#1] \[2007-08-13 14:16:01.750 'App' 1872 warning] \[attachedComputerWin32,579] \[GetVolumesForComputer] Windisk_GetVolumeDiskExtents failed with error 1

\[??] \[2007-08-13 14:16:02.015 'App' 1296 info] \[stub,42] Info\[Windisk_GetVolumeDeviceNumber]: IOCTL_GET_STORAGE_DEVICE_NUMBER for volume
?\Volume\{0e149234-5d28-11d6-b6e0-806d6172696f}\ is not supported .... Trying NT method.

\[??] \[2007-08-13 14:16:02.015 'App' 1296 info] \[stub,42] Error\[Windisk_GetVolumeDeviceNumber]:Failed to get
?\Volume\{0e149234-5d28-11d6-b6e0-806d6172696f}\ Volume's disk number

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[diskSet,196] 3 volumes found

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[diskSet,364] Volume: idx=0 sysId=18 active=N

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[diskSet,364] Volume: idx=1 sysId=7 active=Y

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[diskSet,203] 1 potential active volumes found

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[disposable,69] Registering disposable session object id=localFile=

\[#1] \[2007-08-13 14:16:02.015 'App' 1872 verbose] \[disposable,80] Associating disposable session object id=localFile= with session id=8F54DDD3-D0ED-46E7-9C33-664EDEF0F478

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[extendedOsInfo,395] \[boot loader]

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[extendedOsInfo,395] timeout=30

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[extendedOsInfo,395] default=multi(0)disk(0)rdisk(0)partition(2)\WINNT

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[extendedOsInfo,395] \[operating systems]

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[extendedOsInfo,395] multi(0)disk(0)rdisk(0)partition(2)\WINNT="Microsoft Windows 2000 Server" /fastdetect

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[disposable,122] object explicitly disposed: localFile=

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 info] \[extendedOsInfo,459] SwagNTInfoFromString has Microsoft Windows 2000 Server

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 info] \[extendedOsInfo,178] Returning OS as display Microsoft Windows 2000 Server

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[disposable,69] Registering disposable session object id=localFile=

\[#1] \[2007-08-13 14:16:02.031 'App' 1872 verbose] \[disposable,80] Associating disposable session object id=localFile= with session id=8F54DDD3-D0ED-46E7-9C33-664EDEF0F478