When trying to convert a Virtual PC 2004 XP image I get a message:
An internal error has occured
(sysimage.fault.UnableToDetermineGuestOs).
The logfile contains the following
\[2006-03-09 22:58:41.609 'App' 3316 info] Current working directory: C:\Program Files\VMware\VMware Virtual Machine Importer 2
\[2006-03-09 22:58:41.609 'ThreadPool' 3316 verbose] Setting COM threading model to MTA
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-agent
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-client
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-slave
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-sysMigration
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-sysReconfig
\[2006-03-09 22:58:41.609 'App' 3316 info] Trying ufa-vmImporter
\[2006-03-09 22:58:41.609 'App' 3316 verbose] Plugin 0 path: ufa-agent.dll
\[2006-03-09 22:58:41.609 'App' 3316 verbose] Plugin 0 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-agent.dll
\[2006-03-09 22:58:41.671 'Ufa' 3316 info] Soap port: 8085
\[2006-03-09 22:58:41.703 'Ufa' 3316 info] Plugin initialized
\[2006-03-09 22:58:41.703 'App' 3316 verbose] Plugin 1 path: ufa-client.dll
\[2006-03-09 22:58:41.703 'App' 3316 verbose] Plugin 1 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-client.dll
\[2006-03-09 22:58:42.750 'App' 3316 info] \[plugin,102] UfaClientPlugin Init
\[2006-03-09 22:58:42.750 'App' 3316 verbose] Plugin 2 path: ufa-slave.dll
\[2006-03-09 22:58:42.750 'App' 3316 verbose] Plugin 2 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-slave.dll
\[2006-03-09 22:58:43.015 'App' 3316 info] \[osInfoWin32,110] Microsoft Windows XP
\[2006-03-09 22:58:43.015 'App' 3316 info] \[osInfoWin32,137] Professional
\[2006-03-09 22:58:43.015 'App' 3316 info] \[osInfoWin32,272] Service Pack 2(Build 2600)
\[2006-03-09 22:58:43.015 'App' 3316 info] \[plugin,81] UfaSlavePlugin Init
\[2006-03-09 22:58:43.015 'App' 3316 verbose] Plugin 3 path: ufa-sysMigration.dll
\[2006-03-09 22:58:43.015 'App' 3316 verbose] Plugin 3 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysMigration.dll
\[2006-03-09 22:58:43.218 'App' 3316 info] \[plugin,163] SysMigrationPlugin Init
\[2006-03-09 22:58:43.218 'App' 3316 verbose] Plugin 4 path: ufa-sysReconfig.dll
\[2006-03-09 22:58:43.218 'App' 3316 verbose] Plugin 4 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysReconfig.dll
\[2006-03-09 22:58:43.453 'App' 3316 info] \[plugin,102] SysReconfigPlugin Init
\[2006-03-09 22:58:43.609 'App' 3316 info] \[utils,121] Using temp dir C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,145] Loading reconfiguration data store XML from C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1\reconfigurationDataStore.xml ...
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,199] Populating ReconfigurationDataStore ...
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action LsiLogic
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_1000&dev_0030 patch: C_SYMMPI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\symmpi patch: S_SYMMPI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\symmpi.sys source: BASEOS sourceFileName: symmpi.sys
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action BuslogicMylex
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_BUSLOGIC patch: L_BUSLOGIC
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\buslogic patch: S_BUSLOGIC
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\buslogic.sys source: VMWARE_DRIVERS_CAB sourceFileName: buslogic_for_nt.sys
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_104b&dev_1040 patch: C_VMSCSI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E97B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMSCSI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vmscsi patch: S_VMSCSI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmscsi.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmscsi.sys
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_ACPI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\3&61aaa01&0&80 patch: E_VMSCSI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_NotACPI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\2&ebb567f&0&80 patch: E_VMSCSI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Mouse_Keyboard
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0303 patch: C_PS2KBD
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2KBD
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0303 patch: E_PS2KBD
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0f13 patch: C_PS2MOUSE
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96F-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2MOUSE
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0F13 patch: E_PS2MOUSE
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_8086&dev_7110&cc_0601 patch: C_ISAPNP
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action NT_SVGA_Registry_Updates
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_VMX_SVGA patch: E_VMX_SVGA
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Common_SVGA_Updates
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E968-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMX_SVGA
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: INF\vmx_svga.inf source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.inf
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_fb.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_fb.dll
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_mode.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_mode.dll
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmx_svga.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.sys
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_APCI
\[2006-03-09 22:58:43.765 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\3&61aaa01&0&78 patch: E_VMX_SVGA
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\2&ebb567f&0&78 patch: E_VMX_SVGA
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Restore_i8042_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\i8042prt patch: SKUNKWORKS_S_I8042
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-DRIVER-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_mrxvpc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\MrxVPC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_MRXVPC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcmap
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\VPCMap patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPCMAP patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT4
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPC-S3 patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_5333&DEV_8811&SUBSYS_00000000&REV_00\3&267a616a&0&40 patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\s3legacy patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_vmsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-DRIVER-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_netfin
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_NETFIN patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\NetFin patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqdmi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqalert
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqagent
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action PreserveDriveLetters
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action RemoveUnwantedKeys
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,274] Loading action FixSetupLog
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
ntoskrnl.exe.*\.exe value:
system32
ntoskrnl.exe = "ntoskrnl.exe
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
hal.dll.*\.dll value:
system32
hal.dll = "hal.dll
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k3
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinXP
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinNT4
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition NotWinNT4
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition ACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition MultiProc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition InstallSVGA
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition MustUpdateCoreNTFiles
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition GuestOsIncludesLsiLogicDriver
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition BuslogicMylex
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,485] Loading expression definition Buslogic_vmscsi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration FixSetupLog
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action FixSetupLog
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration BuslogicMylex
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action BuslogicMylex
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration LsiLogic
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action LsiLogic
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_ACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_ACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Mouse_Keyboard_notNT_ACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Mouse_Keyboard
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_NT
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action NT_SVGA_Registry_Updates
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_ACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_APCI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_NotACPI
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Restore_i8042_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Restore_i8042_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_mrxvpc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_mrxvpc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcmap
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcmap
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT4
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT4
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT5
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vmsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vmsrvc
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_netfin
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_netfin
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqdmi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqdmi
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqalert
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqalert
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqagent
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqagent
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration PreserveDriveLetters
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action PreserveDriveLetters
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1032] Loading reconfiguration RemoveUnwantedKeys
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action RemoveUnwantedKeys
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-09 22:58:43.781 'App' 3316 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-09 22:58:43.781 'App' 3316 info] \[utils,148] Cleaning up temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1 ...
\[2006-03-09 22:58:43.781 'App' 3316 warning] \[utils,151] Unable to cleanup and remove temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1
\[2006-03-09 22:58:43.781 'App' 3316 verbose] Plugin 5 path: ufa-vmImporter.dll
\[2006-03-09 22:58:43.781 'App' 3316 verbose] Plugin 5 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-vmImporter.dll
\[2006-03-09 22:58:43.937 'App' 3316 info] \[plugin,106] VMImporterPlugin Init
\[2006-03-09 22:58:43.937 'Ufa' 3316 info] Vmdb port: 9005
\[2006-03-09 22:58:43.937 'Ufa' 3316 info] Plugin started
\[2006-03-09 22:58:43.937 'App' 3316 info] \[plugin,117] UfaClientPlugin Start
\[2006-03-09 22:58:44.000 'App' 3316 info] \[plugin,99] UfaSlavePlugin Start
\[2006-03-09 22:58:44.000 'App' 3316 info] \[plugin,179] SysMigrationPlugin Start
\[2006-03-09 22:58:44.000 'App' 3316 info] \[plugin,119] SysReconfigPlugin Start
\[2006-03-09 22:58:44.000 'App' 3316 info] \[plugin,121] VMImporterPlugin Start
\[2006-03-09 22:58:44.000 'App' 3316 info] \[serviceWin32,380] ufad-vmi service started
\[2006-03-09 22:59:11.343 'App' 3660 info] Current working directory: C:\Documents and Settings\Ade\Desktop
\[2006-03-09 22:59:11.343 'App' 3660 info] \[vmiSupport,139] VMImporter UI logger created
\[2006-03-09 22:59:11.359 'ClientConnection' 3660 info] Connecting to ufa-client on localhost:9005
\[2006-03-09 22:59:11.406 'VmdbSvc' 3660 verbose] Connected to stream: \[class Vmacore::System::TCPClientSocketWin32:0193EE40]
\[2006-03-09 22:59:11.406 'BaseLibs' 3632 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/
\[2006-03-09 22:59:11.437 'App' 3660 info] \[vmiSupport,143] UFA connection established
\[2006-03-09 22:59:22.000 'App' 3064 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-09 22:59:22.046 'App' 3064 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-09 22:59:22.046 'App' 3064 info] \[vmiQueryOsTask,107] vmiQueryOsTask initialized
\[2006-03-09 22:59:22.046 'App' 3064 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-09 22:59:22.859 'Vmsvc' 3064 info] VMServices Plugin initializing
\[2006-03-09 22:59:22.015 'App' 3660 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiQueryOsTask::task\{0}
\[2006-03-09 22:59:22.046 'App' 3660 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-09 22:59:22.546 'App' 3660 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-09 22:59:22.562 'App' 3660 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-09 22:59:23.031 'VmMisc' 3064 info] Max supported virtual machines: 1200
\[2006-03-09 22:59:31.609 'Ufa-foundry' 3064 verbose] Completed opening virtual machine.
\[2006-03-09 22:59:31.625 'Ufa-foundry' 3064 verbose] Close vmHandle called
\[2006-03-09 22:59:31.718 'Ufa-foundry' 3872 verbose] Completed opening virtual machine.
\[2006-03-09 22:59:31.937 'Ufa-foundry' 3872 verbose] Time to gather config: 218 (msecs)
\[2006-03-09 22:59:31.937 'App' 3872 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-09 22:59:31.937 'App' 3872 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-09 22:59:31.937 'App' 3872 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-09 23:00:02.375 'App' 2456 error] \[diskWin32,124] -2147023843
\[2006-03-09 23:00:02.375 'App' 2456 verbose] \[disposable,45] disposable object being destroyed:
\[2006-03-09 23:00:02.375 'Ufa-foundry' 3872 verbose] Close vmHandle called
\[2006-03-09 23:00:02.390 'App' 3872 error] \[client,152]
\[2006-03-09 23:00:02.390 'App' 3064 error] \[vmiQueryOsTask,344] Unable to read OS info from system disk
\[2006-03-09 23:00:02.421 'App' 3064 error] \[imageProcessingTaskImpl,581] Image processing task has failed with a fault: sysimage.fault.UnableToDetermineGuestOs
\[2006-03-09 23:00:02.656 'App' 3872 verbose] \[disposable,109] object explicitly disposed: VmiQueryOsTask::task\{0}
\[2006-03-09 23:00:02.656 'App' 3872 verbose] \[disposable,45] disposable object being destroyed: VmiQueryOsTask::task\{0}
\[2006-03-09 23:00:02.703 'App' 3872 info] \[vmImporter,279] Found UFAD log at .\vmware-ufad.log-1.log
\[2006-03-09 23:00:02.703 'App' 3872 info] \[vmImporter,321] Failed to find VMOUNT log.
\[2006-03-09 23:00:02.421 'App' 3584 verbose] \[imageProcessingTaskWrapper,697] Task completed.
Type 'net start vmount2' and retry the import. If that works, there may be a problem with how we start this service. BTW, did you install VM Importer on a machine running any other VMware products? If so, which ones?
Is "I:" a local drive or networked share? The beta has a known issue with reading Virtual PC images from non-local disks.
Known issues are the end of the release notes:
http://www.vmware.com/products/beta/vmimporter/releasenotes_vmi20.html
I was running the Beta of VMWare Server which I have now removed.
Starting the vmount2 service has got me further but the import now failes on creating the VM.
Drive I is a new SATA drive with 75GB of free space.
I have enclosed the rather long log file.
\[2006-03-11 10:35:35.031 'App' 3412 info] Current working directory: C:\Program Files\VMware\VMware Virtual Machine Importer 2
\[2006-03-11 10:35:35.031 'ThreadPool' 3412 verbose] Setting COM threading model to MTA
\[2006-03-11 10:35:35.046 'App' 3412 info] Trying ufa-agent
\[2006-03-11 10:35:35.046 'App' 3412 info] Trying ufa-client
\[2006-03-11 10:35:35.046 'App' 3412 info] Trying ufa-slave
\[2006-03-11 10:35:35.062 'App' 3412 info] Trying ufa-sysMigration
\[2006-03-11 10:35:35.078 'App' 3412 info] Trying ufa-sysReconfig
\[2006-03-11 10:35:35.078 'App' 3412 info] Trying ufa-vmImporter
\[2006-03-11 10:35:35.078 'App' 3412 verbose] Plugin 0 path: ufa-agent.dll
\[2006-03-11 10:35:35.078 'App' 3412 verbose] Plugin 0 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-agent.dll
\[2006-03-11 10:35:35.281 'Ufa' 3412 info] Soap port: 8085
\[2006-03-11 10:35:35.312 'Ufa' 3412 info] Plugin initialized
\[2006-03-11 10:35:35.312 'App' 3412 verbose] Plugin 1 path: ufa-client.dll
\[2006-03-11 10:35:35.343 'App' 3412 verbose] Plugin 1 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-client.dll
\[2006-03-11 10:35:36.640 'App' 3412 info] \[plugin,102] UfaClientPlugin Init
\[2006-03-11 10:35:36.640 'App' 3412 verbose] Plugin 2 path: ufa-slave.dll
\[2006-03-11 10:35:36.640 'App' 3412 verbose] Plugin 2 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-slave.dll
\[2006-03-11 10:35:37.359 'App' 3412 info] \[osInfoWin32,110] Microsoft Windows XP
\[2006-03-11 10:35:37.359 'App' 3412 info] \[osInfoWin32,137] Professional
\[2006-03-11 10:35:37.359 'App' 3412 info] \[osInfoWin32,272] Service Pack 2(Build 2600)
\[2006-03-11 10:35:37.375 'App' 3412 info] \[plugin,81] UfaSlavePlugin Init
\[2006-03-11 10:35:37.375 'App' 3412 verbose] Plugin 3 path: ufa-sysMigration.dll
\[2006-03-11 10:35:37.375 'App' 3412 verbose] Plugin 3 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysMigration.dll
\[2006-03-11 10:35:38.125 'App' 3412 info] \[plugin,163] SysMigrationPlugin Init
\[2006-03-11 10:35:38.125 'App' 3412 verbose] Plugin 4 path: ufa-sysReconfig.dll
\[2006-03-11 10:35:38.140 'App' 3412 verbose] Plugin 4 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysReconfig.dll
\[2006-03-11 10:35:38.484 'App' 3412 info] \[plugin,102] SysReconfigPlugin Init
\[2006-03-11 10:35:38.578 'App' 3412 info] \[utils,121] Using temp dir C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.2
\[2006-03-11 10:35:38.906 'App' 3412 verbose] \[rdsXmlLoader,145] Loading reconfiguration data store XML from C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.2\reconfigurationDataStore.xml ...
\[2006-03-11 10:35:38.921 'App' 3412 verbose] \[rdsXmlLoader,199] Populating ReconfigurationDataStore ...
\[2006-03-11 10:35:38.921 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action LsiLogic
\[2006-03-11 10:35:38.953 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_1000&dev_0030 patch: C_SYMMPI
\[2006-03-11 10:35:38.953 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\symmpi patch: S_SYMMPI
\[2006-03-11 10:35:38.953 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\symmpi.sys source: BASEOS sourceFileName: symmpi.sys
\[2006-03-11 10:35:38.953 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action BuslogicMylex
\[2006-03-11 10:35:38.953 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_BUSLOGIC patch: L_BUSLOGIC
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\buslogic patch: S_BUSLOGIC
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\buslogic.sys source: VMWARE_DRIVERS_CAB sourceFileName: buslogic_for_nt.sys
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_104b&dev_1040 patch: C_VMSCSI
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E97B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMSCSI
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vmscsi patch: S_VMSCSI
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmscsi.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmscsi.sys
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_ACPI
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\3&61aaa01&0&80 patch: E_VMSCSI
\[2006-03-11 10:35:38.968 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_NotACPI
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\2&ebb567f&0&80 patch: E_VMSCSI
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Mouse_Keyboard
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0303 patch: C_PS2KBD
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2KBD
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0303 patch: E_PS2KBD
\[2006-03-11 10:35:38.984 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0f13 patch: C_PS2MOUSE
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96F-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2MOUSE
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0F13 patch: E_PS2MOUSE
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_8086&dev_7110&cc_0601 patch: C_ISAPNP
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action NT_SVGA_Registry_Updates
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_VMX_SVGA patch: E_VMX_SVGA
\[2006-03-11 10:35:39.000 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-11 10:35:39.015 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Common_SVGA_Updates
\[2006-03-11 10:35:39.015 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-11 10:35:39.031 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E968-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMX_SVGA
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: INF\vmx_svga.inf source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.inf
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_fb.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_fb.dll
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_mode.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_mode.dll
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmx_svga.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.sys
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_APCI
\[2006-03-11 10:35:39.046 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\3&61aaa01&0&78 patch: E_VMX_SVGA
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_NotACPI
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\2&ebb567f&0&78 patch: E_VMX_SVGA
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Restore_i8042_NT5
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\i8042prt patch: SKUNKWORKS_S_I8042
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcsrvc
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.062 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-DRIVER-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_mrxvpc
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\MrxVPC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_MRXVPC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcmap
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\VPCMap patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPCMAP patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT4
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPC-S3 patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT5
\[2006-03-11 10:35:39.078 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.093 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_5333&DEV_8811&SUBSYS_00000000&REV_00\3&267a616a&0&40 patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.093 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\s3legacy patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.093 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_vmsrvc
\[2006-03-11 10:35:39.109 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.125 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-DRIVER-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.125 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.140 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.140 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_netfin
\[2006-03-11 10:35:39.140 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_NETFIN patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.156 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\NetFin patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.156 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqdmi
\[2006-03-11 10:35:39.156 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.171 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.171 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqalert
\[2006-03-11 10:35:39.171 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.187 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.203 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.203 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqagent
\[2006-03-11 10:35:39.203 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action PreserveDriveLetters
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action RemoveUnwantedKeys
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,274] Loading action FixSetupLog
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
ntoskrnl.exe.*\.exe value:
system32
ntoskrnl.exe = "ntoskrnl.exe
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
hal.dll.*\.dll value:
system32
hal.dll = "hal.dll
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k3
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinXP
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinNT4
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition NotWinNT4
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition ACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition NotACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition MultiProc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition InstallSVGA
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition MustUpdateCoreNTFiles
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition GuestOsIncludesLsiLogicDriver
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition BuslogicMylex
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,485] Loading expression definition Buslogic_vmscsi
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration FixSetupLog
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action FixSetupLog
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration BuslogicMylex
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action BuslogicMylex
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration LsiLogic
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action LsiLogic
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_ACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_ACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_NotACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_NotACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Mouse_Keyboard_notNT_ACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Mouse_Keyboard
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_NT
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action NT_SVGA_Registry_Updates
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_ACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_APCI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_NotACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_NotACPI
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Restore_i8042_NT5
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Restore_i8042_NT5
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcsrvc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcsrvc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_mrxvpc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_mrxvpc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcmap
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcmap
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT4
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT4
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT5
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT5
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vmsrvc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vmsrvc
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_netfin
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_netfin
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqdmi
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqdmi
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqalert
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqalert
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqagent
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqagent
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration PreserveDriveLetters
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action PreserveDriveLetters
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1032] Loading reconfiguration RemoveUnwantedKeys
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action RemoveUnwantedKeys
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-11 10:35:39.218 'App' 3412 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-11 10:35:39.218 'App' 3412 info] \[utils,148] Cleaning up temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.2 ...
\[2006-03-11 10:35:39.218 'App' 3412 warning] \[utils,151] Unable to cleanup and remove temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.2
\[2006-03-11 10:35:39.218 'App' 3412 verbose] Plugin 5 path: ufa-vmImporter.dll
\[2006-03-11 10:35:39.218 'App' 3412 verbose] Plugin 5 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-vmImporter.dll
\[2006-03-11 10:35:39.328 'App' 3412 info] \[plugin,106] VMImporterPlugin Init
\[2006-03-11 10:35:39.328 'Ufa' 3412 info] Vmdb port: 9005
\[2006-03-11 10:35:39.328 'Ufa' 3412 info] Plugin started
\[2006-03-11 10:35:39.328 'App' 3412 info] \[plugin,117] UfaClientPlugin Start
\[2006-03-11 10:35:39.437 'App' 3412 info] \[plugin,99] UfaSlavePlugin Start
\[2006-03-11 10:35:39.453 'App' 3412 info] \[plugin,179] SysMigrationPlugin Start
\[2006-03-11 10:35:39.453 'App' 3412 info] \[plugin,119] SysReconfigPlugin Start
\[2006-03-11 10:35:39.468 'App' 3412 info] \[plugin,121] VMImporterPlugin Start
\[2006-03-11 10:35:39.468 'App' 3412 info] \[serviceWin32,380] ufad-vmi service started
\[03/11/06 10:36:51] Status: (vmount:601) vmount2 service started 2.0.0 build-21909
\[2006-03-11 10:36:58.640 'App' 3580 info] Current working directory: C:\Documents and Settings\Ade\Desktop
\[2006-03-11 10:36:58.640 'App' 3580 info] \[vmiSupport,139] VMImporter UI logger created
\[2006-03-11 10:36:58.671 'ClientConnection' 3580 info] Connecting to ufa-client on localhost:9005
\[2006-03-11 10:36:58.703 'VmdbSvc' 3580 verbose] Connected to stream: \[class Vmacore::System::TCPClientSocketWin32:0193EE40]
\[2006-03-11 10:36:58.703 'BaseLibs' 3608 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/
\[2006-03-11 10:36:58.734 'App' 3580 info] \[vmiSupport,143] UFA connection established
\[2006-03-11 10:37:03.984 'App' 2648 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:37:04.031 'App' 3536 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-11 10:37:04.031 'App' 3536 info] \[vmiQueryOsTask,107] vmiQueryOsTask initialized
\[2006-03-11 10:37:04.031 'App' 3536 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:37:04.828 'Vmsvc' 3536 info] VMServices Plugin initializing
\[2006-03-11 10:37:04.000 'App' 3580 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiQueryOsTask::task\{0}
\[2006-03-11 10:37:04.031 'App' 3580 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-11 10:37:04.531 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:37:04.546 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:37:05.046 'VmMisc' 3536 info] Max supported virtual machines: 1200
\[2006-03-11 10:37:05.843 'Ufa-foundry' 3536 verbose] Completed opening virtual machine.
\[2006-03-11 10:37:05.843 'Ufa-foundry' 3536 verbose] Close vmHandle called
\[2006-03-11 10:37:06.000 'Ufa-foundry' 300 verbose] Completed opening virtual machine.
\[2006-03-11 10:37:06.312 'Ufa-foundry' 300 verbose] Time to gather config: 281 (msecs)
\[2006-03-11 10:37:06.312 'App' 300 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-11 10:37:06.328 'App' 300 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-11 10:37:06.343 'App' 300 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-11 10:37:07.343 'Ufa-foundry' 300 verbose] Close vmHandle called
\[2006-03-11 10:37:07.390 'App' 3412 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:07.406 'App' 2648 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y
\[2006-03-11 10:37:07.406 'App' 2648 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[03/11/06 10:37:07] Status: (VmountDisk:234) disk I:\Virtual Machines\WinXP\drive-0.vmdk was opened \[03/11/06 10:37:07] Status: (VmountDevice:1518) device of type volume with offset 32256 was created \[03/11/06 10:37:07] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:08.281 'App' 2648 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:37:08.281 'App' 2648 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:08.281 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:08.281 'App' 2648 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:37:08.281 'App' 2648 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:37:08.281 'App' 2648 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:37:08.281 'App' 300 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:37:08.281 'App' 300 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:08.281 'App' 300 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:08.281 'App' 300 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:08.281 'App' 300 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:08.281 'App' 300 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:08.281 'App' 300 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:08.281 'App' 300 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:08.281 'App' 300 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:37:08.281 'App' 300 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:37:08.296 'App' 300 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:37:08.296 'App' 300 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:37:08.296 'App' 300 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:08.296 'App' 300 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:08.296 'App' 300 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:08.296 'App' 300 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:08.296 'App' 300 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:08.296 'App' 300 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:08.296 'App' 300 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:10.921 'App' 300 info] \[extendedOsInfo,676] ParseNTRegistry FOUND: Microsoft Windows XP root:WINDOWS\ SrvPack:1 SMP:0 64:0 Ver:5.1 \[2006-03-11 10:37:10.921 'App' 300 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer=,1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:37:12.546 'App' 300 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:37:12.546 'App' 300 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:37:12.859 'App' 300 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:37:12.859 'App' 300 info] \[extendedOsInfo,151] Returning OS as winXPHome
\[2006-03-11 10:37:12.859 'App' 3536 info] \[imageProcessorProxy,151] Successfully connected to UfaSysReconfig
\[2006-03-11 10:37:12.859 'App' 300 info] \[ufaClientConnection,56] Successfully connected to local UfaClient.
\[2006-03-11 10:37:12.859 'App' 300 info] \[ufaClientConnection,150] Opening specifed computer ...
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-11 10:37:12.859 'App' 300 verbose] \[computerProxy,67] Successfully connected to remote Computer.
\[2006-03-11 10:37:12.859 'App' 300 verbose] \[computerProxy,248] Connecting to the system volume...
\[2006-03-11 10:37:12.859 'App' 300 verbose] \[computerProxy,139] Retrieving the system volume info ...
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[extendedOsInfo,351] \[boot loader]
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[extendedOsInfo,351] timeout=30
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[extendedOsInfo,351] \[operating systems]
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[disposable,109] object explicitly disposed: localFile=
\[2006-03-11 10:37:12.859 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: localFile=
\[2006-03-11 10:37:12.859 'App' 2648 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional
\[2006-03-11 10:37:12.859 'App' 2648 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional
\[2006-03-11 10:37:12.875 'App' 2648 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-11 10:37:12.875 'App' 300 verbose] \[volumeProxy,51] Successfully connected to remote volume.
\[2006-03-11 10:37:12.921 'App' 300 verbose] \[computerProxy,87] Debug
\[2006-03-11 10:37:12.921 'App' 300 verbose] \[computerProxy,113] Debug
\[2006-03-11 10:37:12.921 'App' 300 verbose] \[volumeProxy,71] Debug
\[2006-03-11 10:37:12.921 'App' 300 info] \[ufaClientConnection,123] Info
\[2006-03-11 10:37:12.921 'App' 2648 verbose] \[disposable,109] object explicitly disposed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:12.921 'App' 2648 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1} \[2006-03-11 10:37:13.984 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1}
\[2006-03-11 10:37:13.984 'App' 2648 verbose] \[disposable,109] object explicitly disposed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:37:13.984 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[03/11/06 10:37:13] Status: (VmountDevice:147) device of type volume with offset 32256 was closed
\[2006-03-11 10:37:14.046 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:14.203 'App' 3536 verbose] \[imageProcessingTaskImpl,560] Image processing task has succeeded...
\[2006-03-11 10:37:14.250 'App' 3412 verbose] \[disposable,109] object explicitly disposed: VmiQueryOsTask::task\{0}
\[2006-03-11 10:37:14.250 'App' 3412 verbose] \[disposable,45] disposable object being destroyed: VmiQueryOsTask::task\{0}
\[2006-03-11 10:37:14.265 'App' 300 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:37:14.312 'App' 3412 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-11 10:37:14.312 'App' 3412 info] \[vmiIsImportAcceptableTask,87] VmiIsImportAcceptableTask initialized
\[2006-03-11 10:37:14.312 'App' 3412 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:37:14.593 'Ufa-foundry' 3536 verbose] Completed opening virtual machine.
\[2006-03-11 10:37:14.687 'Ufa-foundry' 3536 verbose] Time to gather config: 78 (msecs)
\[2006-03-11 10:37:14.687 'App' 3536 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-11 10:37:14.687 'App' 3536 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-11 10:37:14.687 'App' 3536 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[03/11/06 10:37:14] Status: (VmountDisk:414) disk I:\Virtual Machines\WinXP\drive-0.vmdk was closed
\[2006-03-11 10:37:14.203 'App' 3608 verbose] \[imageProcessingTaskWrapper,697] Task completed.
\[2006-03-11 10:37:14.281 'App' 3580 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiIsImportAcceptableTask::task\{1}
\[2006-03-11 10:37:14.312 'App' 3580 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-11 10:37:14.812 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:37:14.828 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:37:15.375 'Ufa-foundry' 3536 verbose] Close vmHandle called
\[2006-03-11 10:37:15.390 'App' 3536 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:15.406 'App' 300 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y
\[2006-03-11 10:37:15.406 'App' 300 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[03/11/06 10:37:15] Status: (VmountDisk:234) disk I:\Virtual Machines\WinXP\drive-0.vmdk was opened \[03/11/06 10:37:15] Status: (VmountDevice:1518) device of type volume with offset 32256 was created \[03/11/06 10:37:15] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:16.265 'App' 300 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:16.265 'App' 300 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:16.265 'App' 300 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:37:16.265 'App' 300 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:16.265 'App' 300 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:16.265 'App' 300 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:16.265 'App' 300 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:37:16.265 'App' 300 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:37:16.265 'App' 300 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:37:16.265 'App' 300 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:37:16.265 'App' 300 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:37:16.281 'App' 300 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:37:16.281 'App' 300 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:37:16.281 'App' 300 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:37:19.109 'App' 300 info] \[extendedOsInfo,676] ParseNTRegistry FOUND: Microsoft Windows XP root:WINDOWS\ SrvPack:1 SMP:0 64:0 Ver:5.1 \[2006-03-11 10:37:19.109 'App' 300 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer=,1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:37:20.781 'App' 300 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:37:20.781 'App' 300 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:37:21.078 'App' 300 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:37:21.078 'App' 300 info] \[extendedOsInfo,151] Returning OS as winXPHome
\[2006-03-11 10:37:21.078 'App' 3412 info] \[localImportSource,134] Source VM name is "OU VIRTUAL MACHINE"
\[2006-03-11 10:37:21.078 'App' 3412 info] \[localImportSource,147] Source capacity=17179869184 Source space used=3005987840
\[2006-03-11 10:37:21.078 'App' 3536 verbose] \[disposable,109] object explicitly disposed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:21.078 'App' 300 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1} \[2006-03-11 10:37:21.125 'App' 300 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1}
\[2006-03-11 10:37:21.125 'App' 300 verbose] \[disposable,109] object explicitly disposed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:37:21.125 'App' 300 verbose] \[disposable,45] disposable object being destroyed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:37:21.171 'App' 300 verbose] \[disposable,45] disposable object being destroyed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:37:21.343 'App' 3412 verbose] \[imageProcessingTaskImpl,560] Image processing task has succeeded...
\[2006-03-11 10:37:21.421 'App' 3412 verbose] \[disposable,109] object explicitly disposed: VmiIsImportAcceptableTask::task\{1}
\[2006-03-11 10:37:21.421 'App' 3412 verbose] \[disposable,45] disposable object being destroyed: VmiIsImportAcceptableTask::task\{1}
\[03/11/06 10:37:21] Status: (VmountDevice:147) device of type volume with offset 32256 was closed
\[03/11/06 10:37:21] Status: (VmountDisk:414) disk I:\Virtual Machines\WinXP\drive-0.vmdk was closed
\[2006-03-11 10:37:21.343 'App' 1684 verbose] \[imageProcessingTaskWrapper,697] Task completed.
\[2006-03-11 10:39:18.421 'App' 2648 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:39:18.468 'App' 300 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-11 10:39:18.468 'App' 300 info] \[vmiIsImportAcceptableTask,87] VmiIsImportAcceptableTask initialized
\[2006-03-11 10:39:18.468 'App' 300 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:39:18.750 'Ufa-foundry' 2648 verbose] Completed opening virtual machine.
\[2006-03-11 10:39:18.828 'Ufa-foundry' 2648 verbose] Time to gather config: 78 (msecs)
\[2006-03-11 10:39:18.828 'App' 2648 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-11 10:39:18.828 'App' 2648 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-11 10:39:18.828 'App' 2648 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-11 10:39:18.437 'App' 3580 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiIsImportAcceptableTask::task\{2}
\[2006-03-11 10:39:18.468 'App' 3580 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-11 10:39:18.968 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:18.984 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:19.156 'Ufa-foundry' 2648 verbose] Close vmHandle called
\[2006-03-11 10:39:19.187 'App' 2648 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:19.187 'App' 4068 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y
\[2006-03-11 10:39:19.187 'App' 4068 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:19.781 'App' 4068 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:39:19.781 'App' 4068 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:19.781 'App' 4068 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:39:19.781 'App' 4068 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:39:19.781 'App' 4068 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:19.781 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: localFile= \[03/11/06 10:39:19] Status: (VmountDisk:234) disk I:\Virtual Machines\WinXP\drive-0.vmdk was opened \[03/11/06 10:39:19] Status: (VmountDevice:1518) device of type volume with offset 32256 was created \[03/11/06 10:39:19] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned \[2006-03-11 10:39:22.812 'App' 4068 info] \[extendedOsInfo,676] ParseNTRegistry FOUND: Microsoft Windows XP root:WINDOWS\ SrvPack:1 SMP:0 64:0 Ver:5.1 \[2006-03-11 10:39:22.812 'App' 4068 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer=,1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:39:24.234 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:39:24.234 'App' 4068 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:39:24.562 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:39:24.562 'App' 4068 info] \[extendedOsInfo,151] Returning OS as winXPHome
\[2006-03-11 10:39:24.562 'App' 300 info] \[localImportSource,134] Source VM name is "OU VIRTUAL MACHINE"
\[2006-03-11 10:39:24.562 'App' 300 info] \[localImportSource,147] Source capacity=17179869184 Source space used=3005987840
\[2006-03-11 10:39:24.562 'App' 300 info] \[localImportDestination,122] Available space=68391768064 Required space=3005987840
\[2006-03-11 10:39:24.562 'App' 4068 verbose] \[disposable,109] object explicitly disposed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:24.562 'App' 4068 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1} \[2006-03-11 10:39:24.593 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1}
\[2006-03-11 10:39:24.593 'App' 4068 verbose] \[disposable,109] object explicitly disposed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:39:24.593 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:39:24.625 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:24.781 'App' 300 verbose] \[imageProcessingTaskImpl,560] Image processing task has succeeded...
\[2006-03-11 10:39:24.843 'App' 4068 verbose] \[disposable,109] object explicitly disposed: VmiIsImportAcceptableTask::task\{2}
\[2006-03-11 10:39:24.843 'App' 4068 verbose] \[disposable,45] disposable object being destroyed: VmiIsImportAcceptableTask::task\{2}
\[03/11/06 10:39:24] Status: (VmountDevice:147) device of type volume with offset 32256 was closed
\[03/11/06 10:39:24] Status: (VmountDisk:414) disk I:\Virtual Machines\WinXP\drive-0.vmdk was closed
\[2006-03-11 10:39:24.781 'App' 3616 verbose] \[imageProcessingTaskWrapper,697] Task completed.
\[2006-03-11 10:39:28.250 'App' 300 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,79] Successfully connected to UfaClient
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,918] Importing from local source I:\Virtual Machines\WinXP\OU Virtual Machine.vmc
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,922] Importing to local destination Windows XPProfessional@I:\Virtual Machines\OU XP
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,947] Creating imported VM for target PRODUCT_WS_500
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,954] Creating a full clone
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,962] Creating disks as MONOLITHIC_SPARSE
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,990] fileCloning is 0
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,998] preallocateDisks not specified; defaulting to FALSE
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,1004] maxBandwidth not specified; throttling disabled
\[2006-03-11 10:39:28.250 'App' 300 info] \[vmiImportTask,1010] thinProvisioning not specified; defaulting to FALSE
\[2006-03-11 10:39:28.296 'App' 3536 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-11 10:39:28.296 'App' 3536 info] \[vmiImportTask,382] Starting VM Import...
\[2006-03-11 10:39:28.296 'App' 3536 info] \[vmiImportTask,333] vmiImportTask initialized
\[2006-03-11 10:39:28.296 'App' 3536 verbose] \[vmiImportTask,456] VmiImportTask::DoRun - Calling GetComputerSpec(I:\Virtual Machines\WinXP\OU Virtual Machine.vmc)
\[2006-03-11 10:39:28.390 'App' 3536 verbose] \[vmiImportTask,464] VmiImportTask::DoRun - Calling CreateComputerObject()
\[2006-03-11 10:39:28.546 'Ufa-foundry' 2648 verbose] Completed opening virtual machine.
\[2006-03-11 10:39:28.640 'Ufa-foundry' 2648 verbose] Time to gather config: 93 (msecs)
\[2006-03-11 10:39:28.640 'App' 2648 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-11 10:39:28.640 'App' 2648 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=I:\Virtual Machines\WinXP\drive-0.vmdk
\[2006-03-11 10:39:28.640 'App' 2648 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-11 10:39:28.265 'App' 3580 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiImportTask::task\{3}
\[2006-03-11 10:39:28.296 'App' 3580 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-11 10:39:28.796 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:28.812 'App' 3580 info] \[vmiSupport,477] import 0% complete.
\[2006-03-11 10:39:28.812 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:29.156 'Ufa-foundry' 2648 verbose] Close vmHandle called
\[2006-03-11 10:39:29.171 'App' 2648 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:29.187 'App' 4044 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y
\[2006-03-11 10:39:29.187 'App' 4044 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[03/11/06 10:39:29] Status: (VmountDisk:234) disk I:\Virtual Machines\WinXP\drive-0.vmdk was opened \[03/11/06 10:39:29] Status: (VmountDevice:1518) device of type volume with offset 32256 was created \[03/11/06 10:39:29] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:30.171 'App' 4044 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:39:30.171 'App' 4044 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:30.171 'App' 4044 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:30.187 'App' 4044 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:39:30.187 'App' 4044 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:39:30.187 'App' 4044 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:39:30.187 'App' 3536 verbose] \[vmiImportTask,496] VmiImportTask::DoRun - Calling Clone() \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[ufaConnection,87] Creating local adapter... \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[slaveConnection,183] Creating local connection to the co-located slave \[2006-03-11 10:39:30.187 'App' 4044 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e} \[2006-03-11 10:39:30.187 'App' 4068 verbose] \[diskSet,263] GetDisks: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e} \[2006-03-11 10:39:30.187 'App' 3536 verbose] \[vmiImportTask,661] Successfully created target storage layout \[2006-03-11 10:39:30.187 'App' 3536 info] \[vmiImportTask,269] Successfully connected to UfaLocalVMCreator \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:30.187 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:30.187 'App' 2648 info] \[extendedOsInfo,415] SwagNTInfoFromString has Microsoft Windows XP Professional \[2006-03-11 10:39:30.187 'App' 2648 info] \[extendedOsInfo,149] Returning OS as display Microsoft Windows XP Professional \[2006-03-11 10:39:30.203 'App' 2648 info] \[diskSet,238] OS resides on partition 1 , disk path I:\Virtual Machines\WinXP\drive-0.vmdk \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[diskSet,296] Volume: idx=0 sysId=7 active=Y \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[extendedOsInfo,351] \[boot loader] \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[extendedOsInfo,351] timeout=30 \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[extendedOsInfo,351] default=multi(0)disk(0)rdisk(0)partition(1)\WINDOWS \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[extendedOsInfo,351] \[operating systems] \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[extendedOsInfo,351] multi(0)disk(0)rdisk(0)partition(1)\WINDOWS="Microsoft Windows XP Professional" /fastdetect \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[disposable,109] object explicitly disposed: localFile= \[2006-03-11 10:39:30.203 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: localFile= \[2006-03-11 10:39:32.906 'App' 2648 info] \[extendedOsInfo,676] ParseNTRegistry FOUND: Microsoft Windows XP root:WINDOWS\ SrvPack:1 SMP:0 64:0 Ver:5.1 \[2006-03-11 10:39:32.906 'App' 2648 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer=,1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:39:34.406 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SYSTEM
\[2006-03-11 10:39:34.406 'App' 2648 verbose] \[disposable,109] object explicitly disposed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:39:34.796 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: fileRegistry=\{virtVol={computer={fcaa32d1fbd15d517ef7cb1bda541aa55734ded0},1}},WINDOWS\system32\config\SOFTWARE
\[2006-03-11 10:39:34.796 'App' 2648 info] \[extendedOsInfo,151] Returning OS as winXPHome
\[2006-03-11 10:39:34.796 'App' 2648 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-11 10:39:34.812 'App' 4068 verbose] Connected to stream: \[class Vmacore::System::TCPClientSocketWin32:04C38AB8]
\[2006-03-11 10:39:34.812 'BaseLibs' 300 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/
\[2006-03-11 10:39:34.828 'App' 4068 verbose] \[slaveConnection,215] Creating vmdb connection to a remote ufad at localhost:9005
\[2006-03-11 10:39:34.843 'App' 3412 verbose] \[attachedDiskWin32,255] QueryDosDevice: ret=0 size=1024 err=122
\[2006-03-11 10:39:34.843 'App' 3412 verbose] \[attachedDiskWin32,255] QueryDosDevice: ret=0 size=2048 err=122
\[2006-03-11 10:39:34.843 'App' 3412 verbose] \[attachedDiskWin32,255] QueryDosDevice: ret=0 size=4096 err=122
\[2006-03-11 10:39:34.843 'App' 3412 verbose] \[attachedDiskWin32,255] QueryDosDevice: ret=0 size=8192 err=122
\[2006-03-11 10:39:34.843 'App' 3412 verbose] \[attachedDiskWin32,255] QueryDosDevice: ret=9340 size=16384 err=0
\[2006-03-11 10:39:35.046 'App' 2108 error] \[attachedDiskWin32,150] error reading geometry: The device is not ready (21)
\[2006-03-11 10:39:35.046 'App' 2108 verbose] \[disposable,45] disposable object being destroyed:
\[2006-03-11 10:39:35.062 'App' 4068 verbose] ============BEGIN FAILED METHOD CALL DUMP============
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Invoking \[openDisk] on \[sysimage.UfaSlave:UfaSlave]
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Arg spec:
(sysimage.AttachedDiskSpec) {
name = "
.\PhysicalDrive4",
attachPoint = (sysimage.DiskAttachPoint) null
}
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Arg options:
(sysimage.DiskOptions) {
nonPersistent = false
}
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Fault has an empty message
\[2006-03-11 10:39:35.062 'App' 4068 verbose] =============END FAILED METHOD CALL DUMP=============
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Shutting down VMDB service...
\[2006-03-11 10:39:35.062 'App' 4068 verbose] Unregistering callback...
\[2006-03-11 10:39:35.062 'App' 4068 verbose] ...done
\[2006-03-11 10:39:35.062 'ThreadPool' 4044 warning] ERROR_NETNAME_DELETED received on handle 00000610
\[2006-03-11 10:39:35.062 'ThreadPool' 3412 warning] ERROR_NETNAME_DELETED received on handle 00000288
\[2006-03-11 10:39:35.062 'App' 4068 error] \[client,152]
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] create VM: 100% completed
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] create and clone to VM: 5% completed
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] Clone and reconfigure VM: 4% completed
\[2006-03-11 10:39:35.062 'App' 3536 error] \[vmiImportTask,677] Error during creation of target VM
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] create and clone to VM: 100% completed
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] Clone and reconfigure VM: 95% completed
\[2006-03-11 10:39:35.062 'App' 3536 verbose] \[imageProcessingTaskStep,294] Clone and reconfigure VM: 100% completed
\[2006-03-11 10:39:35.062 'App' 2648 verbose] \[disposable,109] object explicitly disposed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:35.062 'App' 2648 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1} \[2006-03-11 10:39:35.093 'VmdbSvc' 4068 warning] IVmdbPipe2Impl: Write-initiate failed: An existing connection was forcibly closed by the remote host. \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,109] object implicitly disposed: disk=\{3b3e1f9bf8866abe770fcf2f136d372042f12e39} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,109] object implicitly disposed: disk=\{5c822bdfe4346fded26a0a0854198ded817c6666} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,109] object implicitly disposed: disk=\{961925382f53577de35e883c6987f0bc8486d21} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,109] object implicitly disposed: disk=\{9ba2498e79b590fd75d62d8b65fa945c367c0fea} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: disk=\{9ba2498e79b590fd75d62d8b65fa945c367c0fea} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: disk=\{961925382f53577de35e883c6987f0bc8486d21} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: disk=\{5c822bdfe4346fded26a0a0854198ded817c6666} \[2006-03-11 10:39:35.109 'App' 4044 verbose] \[disposable,45] disposable object being destroyed: disk=\{3b3e1f9bf8866abe770fcf2f136d372042f12e39} \[2006-03-11 10:39:35.109 'VmdbAdapter' 4044 verbose] Removed vmdb connection /db/connection/#2/ \[2006-03-11 10:39:35.140 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1}
\[2006-03-11 10:39:35.140 'App' 2648 verbose] \[disposable,109] object explicitly disposed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:39:35.140 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: computer=\{fcaa32d1fbd15d517ef7cb1bda541aa55734ded0}
\[2006-03-11 10:39:35.203 'App' 2648 verbose] \[disposable,45] disposable object being destroyed: disk=\{2a9c02205ca3d7d7c83d38b33c6f6f18f67f572e}
\[2006-03-11 10:39:35.359 'App' 3536 error] \[imageProcessingTaskImpl,581] Image processing task has failed with a fault: sysimage.fault.VmCreationFault
\[2006-03-11 10:39:35.437 'App' 300 verbose] \[disposable,109] object explicitly disposed: VmiImportTask::task\{3}
\[2006-03-11 10:39:35.437 'App' 300 verbose] \[disposable,45] disposable object being destroyed: VmiImportTask::task\{3}
\[2006-03-11 10:39:35.453 'App' 3536 info] \[vmImporter,279] Found UFAD log at .\vmware-ufad.log-2.log
\[2006-03-11 10:39:35.468 'App' 3536 info] \[vmImporter,302] Found VMOUNT log at C:\WINDOWS\TEMP\vmware-vmount.log
\[03/11/06 10:39:35] Status: (VmountDevice:147) device of type volume with offset 32256 was closed
\[03/11/06 10:39:35] Status: (VmountDisk:414) disk I:\Virtual Machines\WinXP\drive-0.vmdk was closed
\[2006-03-11 10:39:35.093 'App' 3580 info] \[vmiSupport,477] import 4% complete.
\[2006-03-11 10:39:35.109 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:35.125 'App' 3580 info] \[vmiSupport,477] import 100% complete.
\[2006-03-11 10:39:35.125 'App' 3580 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-11 10:39:35.359 'App' 1684 verbose] \[imageProcessingTaskWrapper,697] Task completed.
Is there anything unusual about the VM you are trying to import? Does is it have multiple boot partititions? Does it boot off of a partition other than the primary one?
It looks like the VM Importer service is still having a hard time reading the virtual disk. Did you simply shutdown VM server? Is it possible to completely remove vm server, vm importer 2, reinstall vm importer 2 and retry?
Have you tried to open up this image directly in VM server? I know thaw WS 5.5 includes a previous release of VM Importer, and allows users to open up Virtual PC images directly. I am not sure if this functionality made it into VM server, but it may be worth trying.
I already tried the uninstall / reinstall and this made no difference (Although I did discover that I had to remove VM Importer2 first or the uninstall of VM Server would just hang).
I have found a workaround in that the VM Importer 1.5.0-18430 does convert the Vm correctly and this is now running fine (although it has created 10 .vmdk files to the singe VPC .vhd file).
I will try again with the next release of VM Importer2 when it is available.
I am having the same kind of problem. I have successfully imported a basic Windows 2000 Pro guest from MS Virtual PC but the 2000 Advanced Server I am trying to import has the same error with the following log:
\[2006-03-20 19:35:13.296 'App' 1256 info] Current working directory: C:\Program Files\VMware\VMware Virtual Machine Importer 2
\[2006-03-20 19:35:13.296 'ThreadPool' 1256 verbose] Setting COM threading model to MTA
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-agent
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-client
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-slave
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-sysMigration
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-sysReconfig
\[2006-03-20 19:35:13.296 'App' 1256 info] Trying ufa-vmImporter
\[2006-03-20 19:35:13.296 'App' 1256 verbose] Plugin 0 path: ufa-agent.dll
\[2006-03-20 19:35:13.296 'App' 1256 verbose] Plugin 0 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-agent.dll
\[2006-03-20 19:35:13.328 'Ufa' 1256 info] Soap port: 8085
\[2006-03-20 19:35:13.328 'Ufa' 1256 info] Plugin initialized
\[2006-03-20 19:35:13.328 'App' 1256 verbose] Plugin 1 path: ufa-client.dll
\[2006-03-20 19:35:13.328 'App' 1256 verbose] Plugin 1 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-client.dll
\[2006-03-20 19:35:13.437 'App' 1256 info] \[plugin,102] UfaClientPlugin Init
\[2006-03-20 19:35:13.437 'App' 1256 verbose] Plugin 2 path: ufa-slave.dll
\[2006-03-20 19:35:13.437 'App' 1256 verbose] Plugin 2 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-slave.dll
\[2006-03-20 19:35:13.609 'App' 1256 info] \[osInfoWin32,110] Microsoft Windows XP
\[2006-03-20 19:35:13.609 'App' 1256 info] \[osInfoWin32,137] Professional
\[2006-03-20 19:35:13.640 'App' 1256 info] \[osInfoWin32,272] Service Pack 2(Build 2600)
\[2006-03-20 19:35:13.640 'App' 1256 info] \[plugin,81] UfaSlavePlugin Init
\[2006-03-20 19:35:13.640 'App' 1256 verbose] Plugin 3 path: ufa-sysMigration.dll
\[2006-03-20 19:35:13.640 'App' 1256 verbose] Plugin 3 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysMigration.dll
\[2006-03-20 19:35:13.843 'App' 1256 info] \[plugin,163] SysMigrationPlugin Init
\[2006-03-20 19:35:13.843 'App' 1256 verbose] Plugin 4 path: ufa-sysReconfig.dll
\[2006-03-20 19:35:13.843 'App' 1256 verbose] Plugin 4 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-sysReconfig.dll
\[2006-03-20 19:35:14.031 'App' 1256 info] \[plugin,102] SysReconfigPlugin Init
\[2006-03-20 19:35:14.171 'App' 1256 info] \[utils,121] Using temp dir C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1
\[2006-03-20 19:35:14.265 'App' 1256 verbose] \[rdsXmlLoader,145] Loading reconfiguration data store XML from C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1\reconfigurationDataStore.xml ...
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,199] Populating ReconfigurationDataStore ...
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action LsiLogic
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_1000&dev_0030 patch: C_SYMMPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\symmpi patch: S_SYMMPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\symmpi.sys source: BASEOS sourceFileName: symmpi.sys
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action BuslogicMylex
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_BUSLOGIC patch: L_BUSLOGIC
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\buslogic patch: S_BUSLOGIC
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\buslogic.sys source: VMWARE_DRIVERS_CAB sourceFileName: buslogic_for_nt.sys
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_104b&dev_1040 patch: C_VMSCSI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E97B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMSCSI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vmscsi patch: S_VMSCSI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmscsi.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmscsi.sys
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\3&61aaa01&0&80 patch: E_VMSCSI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Buslogic_vmscsi_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_104B&DEV_1040&SUBSYS_1040104B&REV_01\2&ebb567f&0&80 patch: E_VMSCSI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Mouse_Keyboard
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0303 patch: C_PS2KBD
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96B-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2KBD
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0303 patch: E_PS2KBD
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\*pnp0f13 patch: C_PS2MOUSE
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E96F-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_PS2MOUSE
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\ACPI\PNP0F13 patch: E_PS2MOUSE
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\CriticalDeviceDatabase\pci#ven_8086&dev_7110&cc_0601 patch: C_ISAPNP
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action NT_SVGA_Registry_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: enum\root\LEGACY_VMX_SVGA patch: E_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Common_SVGA_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: services\vmx_svga patch: S_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Control\Class\{4D36E968-E325-11CE-BFC1-08002BE10318}\0009 patch: CL_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: INF\vmx_svga.inf source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.inf
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_fb.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_fb.dll
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\vmx_mode.dll source: VMWARE_DRIVERS_CAB sourceFileName: vmx_mode.dll
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,410] File Update filePathInWinDir: system32\drivers\vmx_svga.sys source: VMWARE_DRIVERS_CAB sourceFileName: vmx_svga.sys
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_APCI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\3&61aaa01&0&78 patch: E_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action SVGA_Registry_Updates_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_15AD&DEV_0405&SUBSYS_040515AD&REV_00\2&ebb567f&0&78 patch: E_VMX_SVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Restore_i8042_NT5
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\i8042prt patch: SKUNKWORKS_S_I8042
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcsrvc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vpcsrvc patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-DRIVER-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\LEGACY_1-VPCSRVC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_mrxvpc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\MrxVPC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_MRXVPC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_vpcmap
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\VPCMap patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPCMAP patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT4
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_VPC-S3 patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_vpc-s3_NT5
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\vpc-s3 patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\PCI\VEN_5333&DEV_8811&SUBSYS_00000000&REV_00\3&267a616a&0&40 patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\s3legacy patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_vmsrvc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-driver-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-DRIVER-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\1-vmsrvc patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_1-VMSRVC patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_netfin
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_NETFIN patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\NetFin patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqdmi
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQDMI patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqalert
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Enum\Root\LEGACY_CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\CPQALERT patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action Deref_cpqagent
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\EventLog\System\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,360] Registry Update currentControlSetKey: Services\Snmp patch: SKUNKWORKS_FILLER
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action PreserveDriveLetters
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action RemoveUnwantedKeys
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,274] Loading action FixSetupLog
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
ntoskrnl.exe.*\.exe value:
system32
ntoskrnl.exe = "ntoskrnl.exe
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,451] String replace Update filePathInWinDir: repair\setup.log pattern:
system32
hal.dll.*\.dll value:
system32
hal.dll = "hal.dll
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k3
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinXP
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWin2k
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition GenericWinNT4
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition NotWinNT4
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition MultiProc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition InstallSVGA
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition MustUpdateCoreNTFiles
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition GuestOsIncludesLsiLogicDriver
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition BuslogicMylex
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,485] Loading expression definition Buslogic_vmscsi
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration FixSetupLog
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action FixSetupLog
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration BuslogicMylex
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action BuslogicMylex
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration LsiLogic
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action LsiLogic
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Buslogic_vmscsi_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Buslogic_vmscsi_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Mouse_Keyboard_notNT_ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Mouse_Keyboard
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_NT
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action NT_SVGA_Registry_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_ACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_APCI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration SVGA_notNT_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Common_SVGA_Updates
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action SVGA_Registry_Updates_NotACPI
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Restore_i8042_NT5
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Restore_i8042_NT5
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcsrvc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcsrvc
\[2006-03-20 19:35:14.312 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_mrxvpc
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_mrxvpc
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpcmap
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpcmap
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT4
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT4
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vpc-s3_NT5
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vpc-s3_NT5
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_vmsrvc
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_vmsrvc
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_netfin
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_netfin
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqdmi
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqdmi
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqalert
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqalert
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration Deref_cpqagent
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action Deref_cpqagent
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration PreserveDriveLetters
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action PreserveDriveLetters
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1032] Loading reconfiguration RemoveUnwantedKeys
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1100] Loading reconfiguration action RemoveUnwantedKeys
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-20 19:35:14.328 'App' 1256 verbose] \[rdsXmlLoader,1154] Loading hotfixes for WINDOWS4.0
\[2006-03-20 19:35:14.328 'App' 1256 info] \[utils,148] Cleaning up temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1 ...
\[2006-03-20 19:35:14.328 'App' 1256 warning] \[utils,151] Unable to cleanup and remove temp directory C:\WINDOWS\TEMP\vmware-SYSTEM\sysReconfig.1
\[2006-03-20 19:35:14.328 'App' 1256 verbose] Plugin 5 path: ufa-vmImporter.dll
\[2006-03-20 19:35:14.328 'App' 1256 verbose] Plugin 5 absolute path: C:\Program Files\VMware\VMware Virtual Machine Importer 2\ufa-vmImporter.dll
\[2006-03-20 19:35:14.437 'App' 1256 info] \[plugin,106] VMImporterPlugin Init
\[2006-03-20 19:35:14.437 'Ufa' 1256 info] Vmdb port: 9005
\[2006-03-20 19:35:14.453 'Ufa' 1256 info] Plugin started
\[2006-03-20 19:35:14.453 'App' 1256 info] \[plugin,117] UfaClientPlugin Start
\[2006-03-20 19:35:14.515 'App' 1256 info] \[plugin,99] UfaSlavePlugin Start
\[2006-03-20 19:35:14.515 'App' 1256 info] \[plugin,179] SysMigrationPlugin Start
\[2006-03-20 19:35:14.515 'App' 1256 info] \[plugin,119] SysReconfigPlugin Start
\[2006-03-20 19:35:14.515 'App' 1256 info] \[plugin,121] VMImporterPlugin Start
\[2006-03-20 19:35:14.515 'App' 1256 info] \[serviceWin32,380] ufad-vmi service started
\[03/20/06 19:35:16] Status: (vmount:601) vmount2 service started 2.0.0 build-21909
\[2006-03-20 19:36:08.000 'App' 1256 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-20 19:36:08.046 'App' 3532 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-20 19:36:08.046 'App' 3532 info] \[vmiQueryOsTask,107] vmiQueryOsTask initialized
\[2006-03-20 19:36:08.046 'App' 3532 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-20 19:36:08.828 'Vmsvc' 3532 info] VMServices Plugin initializing
\[2006-03-20 19:36:08.953 'VmMisc' 3532 info] Max supported virtual machines: 1200
\[2006-03-20 19:36:09.203 'Ufa-foundry' 3532 verbose] Completed opening virtual machine.
\[2006-03-20 19:36:09.203 'Ufa-foundry' 3532 verbose] Close vmHandle called
\[2006-03-20 19:36:09.281 'Ufa-foundry' 1256 verbose] Completed opening virtual machine.
\[2006-03-20 19:36:09.328 'Ufa-foundry' 1256 verbose] Time to gather config: 46 (msecs)
\[2006-03-20 19:36:09.328 'App' 1256 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-20 19:36:09.328 'App' 1256 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk
\[2006-03-20 19:36:09.328 'App' 1256 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk
\[2006-03-20 19:36:09.328 'App' 1256 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk
\[2006-03-20 19:36:09.328 'App' 1256 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[2006-03-20 19:36:10.593 'Ufa-foundry' 1256 verbose] Close vmHandle called
\[2006-03-20 19:36:10.625 'App' 1256 verbose] \[diskSet,263] GetDisks: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23}
\[2006-03-20 19:36:10.625 'App' 1256 verbose] \[diskSet,263] GetDisks: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e}
\[2006-03-20 19:36:10.625 'App' 1256 verbose] \[diskSet,263] GetDisks: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9}
\[03/20/06 19:36:10] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk was opened
\[03/20/06 19:36:10] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk was opened
\[03/20/06 19:36:10] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk was opened
\[2006-03-20 19:36:11.703 'App' 1256 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition \[03/20/06 19:36:11] Status: (VmountDevice:1518) device of type volume with offset 14848 was created \[03/20/06 19:36:11] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned \[2006-03-20 19:36:12.312 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: \[2006-03-20 19:36:12.312 'App' 1256 info] \[extendedOsInfo,132] boot.ini is non-existent or inaccessible \[2006-03-20 19:36:12.312 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: \[2006-03-20 19:36:12.312 'App' 1256 info] \[extendedOsInfo,142] msdos.sys is non-existent or inaccessible \[2006-03-20 19:36:12.312 'App' 1256 error] \[extendedOsInfo,155] FAILED parsing NTFS or Win9x_DOS partition \[2006-03-20 19:36:12.312 'App' 3532 error] \[vmiQueryOsTask,344] Unable to read OS info from system disk \[2006-03-20 19:36:12.312 'App' 2232 verbose] \[disposable,109] object explicitly disposed: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23} \[2006-03-20 19:36:12.312 'App' 1256 verbose] \[disposable,109] object explicitly disposed: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e} \[2006-03-20 19:36:12.312 'App' 2232 verbose] \[disposable,109] object explicitly disposed: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9} \[2006-03-20 19:36:12.312 'App' 1256 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1}
\[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1} \[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,2}
\[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,2} \[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,3}
\[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,3} \[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,4}
\[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,4} \[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,5}
\[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,5} \[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,6}
\[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,6} \[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,7}
\[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,7} \[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,8}
\[2006-03-20 19:36:12.343 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,8} \[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,9}
\[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,9} \[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,109] object explicitly disposed: computer=\
\[2006-03-20 19:36:12.343 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: computer=\{b966d1d2eda6698b301e2c63106bdab5b71ee123}
\[2006-03-20 19:36:12.453 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23}
\[2006-03-20 19:36:12.593 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e}
\[2006-03-20 19:36:12.781 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9}
\[03/20/06 19:36:12] Status: (VmountDevice:147) device of type disk with offset 0 was closed
\[03/20/06 19:36:12] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk was closed
\[03/20/06 19:36:12] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk was closed
\[03/20/06 19:36:12] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk was closed
\[2006-03-20 19:36:13.546 'App' 3532 error] \[imageProcessingTaskImpl,581] Image processing task has failed with a fault: sysimage.fault.UnableToDetermineGuestOs
\[2006-03-20 19:36:13.640 'App' 1256 verbose] \[disposable,109] object explicitly disposed: VmiQueryOsTask::task\{0}
\[2006-03-20 19:36:13.640 'App' 1256 verbose] \[disposable,45] disposable object being destroyed: VmiQueryOsTask::task\{0}
\[2006-03-20 19:36:13.687 'App' 3532 info] \[vmImporter,279] Found UFAD log at .\vmware-ufad.log-1.log
\[2006-03-20 19:36:13.687 'App' 3532 info] \[vmImporter,302] Found VMOUNT log at C:\WINDOWS\TEMP\vmware-vmount.log
\[2006-03-20 19:36:58.265 'VmdbAdapter' 2224 verbose] Removed vmdb connection /db/connection/#1/
\[2006-03-20 19:37:03.984 'App' 984 info] Current working directory: C:\Documents and Settings\Toby\Desktop
\[2006-03-20 19:37:03.984 'App' 984 info] \[vmiSupport,139] VMImporter UI logger created
\[2006-03-20 19:37:03.984 'ClientConnection' 984 info] Connecting to ufa-client on localhost:9005
\[2006-03-20 19:37:03.984 'VmdbSvc' 984 verbose] Connected to stream: \[class Vmacore::System::TCPClientSocketWin32:01980EB8]
\[2006-03-20 19:37:03.984 'BaseLibs' 1692 warning] \[Vmdb_Unset] Unsetting unknown path: /vmomi/
\[2006-03-20 19:37:04.031 'App' 984 info] \[vmiSupport,143] UFA connection established
\[2006-03-20 19:37:09.359 'App' 2224 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-20 19:37:09.406 'App' 2620 verbose] \[imageProcessingTaskImpl,551] Starting execution of an image processing task...
\[2006-03-20 19:37:09.406 'App' 2620 info] \[vmiQueryOsTask,107] vmiQueryOsTask initialized
\[2006-03-20 19:37:09.406 'App' 2620 verbose] \[ufaConnection,87] Creating local adapter...
\[2006-03-20 19:37:09.937 'Ufa-foundry' 2620 verbose] Completed opening virtual machine.
\[2006-03-20 19:37:09.937 'Ufa-foundry' 2620 verbose] Close vmHandle called
\[2006-03-20 19:37:09.375 'App' 984 verbose] \[imageProcessingTaskWrapper,70] Successfully connected to VmiQueryOsTask::task\{1}
\[2006-03-20 19:37:09.406 'App' 984 verbose] \[imageProcessingTaskWrapper,621] Start managed object method...
\[2006-03-20 19:37:09.906 'App' 984 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-20 19:37:10.031 'Ufa-foundry' 2224 verbose] Completed opening virtual machine.
\[2006-03-20 19:37:10.078 'Ufa-foundry' 2224 verbose] Time to gather config: 46 (msecs)
\[2006-03-20 19:37:10.078 'App' 2224 verbose] \[foundryParser,346] Adding controller for IDE bus 0 with key 200.
\[2006-03-20 19:37:10.078 'App' 2224 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk
\[2006-03-20 19:37:10.078 'App' 2224 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk
\[2006-03-20 19:37:10.078 'App' 2224 info] \[foundryParser,517] LocalVirtualDiskSpec: Name=C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk
\[2006-03-20 19:37:10.078 'App' 2224 verbose] \[slaveConnection,183] Creating local connection to the co-located slave
\[03/20/06 19:37:10] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk was opened
\[03/20/06 19:37:10] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk was opened
\[2006-03-20 19:37:10.000 'App' 984 verbose] \[imageProcessingTaskWrapper,358] Waiting for updates...
\[2006-03-20 19:37:11.312 'Ufa-foundry' 2224 verbose] Close vmHandle called
\[2006-03-20 19:37:11.343 'App' 2224 verbose] \[diskSet,263] GetDisks: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23}
\[2006-03-20 19:37:11.343 'App' 2224 verbose] \[diskSet,263] GetDisks: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e}
\[2006-03-20 19:37:11.343 'App' 2224 verbose] \[diskSet,263] GetDisks: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9}
\[03/20/06 19:37:11] Status: (VmountDisk:234) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk was opened
\[2006-03-20 19:37:12.375 'App' 2224 verbose] \[virtualVolumeWin32,181] Mounting virtual volume virtVol=\{computer=,1}... \[2006-03-20 19:37:12.796 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: \[2006-03-20 19:37:12.796 'App' 2224 info] \[extendedOsInfo,132] boot.ini is non-existent or inaccessible \[2006-03-20 19:37:12.812 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: \[2006-03-20 19:37:12.812 'App' 2224 info] \[extendedOsInfo,142] msdos.sys is non-existent or inaccessible \[2006-03-20 19:37:12.812 'App' 2224 error] \[extendedOsInfo,155] FAILED parsing NTFS or Win9x_DOS partition \[2006-03-20 19:37:12.812 'App' 2620 error] \[vmiQueryOsTask,344] Unable to read OS info from system disk \[2006-03-20 19:37:12.812 'App' 2224 verbose] \[disposable,109] object explicitly disposed: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23} \[2006-03-20 19:37:12.812 'App' 2224 verbose] \[disposable,109] object explicitly disposed: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e} \[2006-03-20 19:37:12.812 'App' 2224 verbose] \[disposable,109] object explicitly disposed: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9} \[2006-03-20 19:37:12.812 'App' 2224 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,1}
\[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,1} \[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,2}
\[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,2} \[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,3}
\[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,3} \[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,4}
\[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,4} \[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,5}
\[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,5} \[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,6}
\[2006-03-20 19:37:12.828 'App' 2224 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,6} \[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,7}
\[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,7} \[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,8}
\[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,8} \[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,109] object explicitly disposed: virtVol=\{computer=,9}
\[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: virtVol=\{computer=,9} \[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,109] object explicitly disposed: computer=\
\[2006-03-20 19:37:12.828 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: computer=\{b966d1d2eda6698b301e2c63106bdab5b71ee123}
\[2006-03-20 19:37:12.921 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: disk=\{d0a8618c4049e7e86d52895869c3e6074c4b7a23}
\[2006-03-20 19:37:12.968 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: disk=\{5febb8e5ead7bc2e581bf9ae440bbd0f57f2799e}
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Volume2: This volume is not associated with a particular partition
\[03/20/06 19:37:12] Status: (VmountDevice:1518) device of type volume with offset 14848 was created
\[03/20/06 19:37:12] Error: (VmountLocator:114) Vmount2.Vmount2Device: no drive letter currently assigned
\[03/20/06 19:37:12] Status: (VmountDevice:147) device of type disk with offset 0 was closed
\[03/20/06 19:37:12] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-0.vmdk was closed
\[03/20/06 19:37:12] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-1.vmdk was closed
\[2006-03-20 19:37:13.031 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: disk=\{11aaba861dfad013c4ae0a3bdf7471906d335df9}
\[2006-03-20 19:37:13.250 'App' 2620 error] \[imageProcessingTaskImpl,581] Image processing task has failed with a fault: sysimage.fault.UnableToDetermineGuestOs
\[2006-03-20 19:37:13.296 'App' 2232 verbose] \[disposable,109] object explicitly disposed: VmiQueryOsTask::task\{1}
\[2006-03-20 19:37:13.296 'App' 2232 verbose] \[disposable,45] disposable object being destroyed: VmiQueryOsTask::task\{1}
\[2006-03-20 19:37:13.312 'App' 2232 info] \[vmImporter,279] Found UFAD log at .\vmware-ufad.log-1.log
\[2006-03-20 19:37:13.312 'App' 2232 info] \[vmImporter,302] Found VMOUNT log at C:\WINDOWS\TEMP\vmware-vmount.log
\[03/20/06 19:37:13] Status: (VmountDisk:414) disk C:\Documents and Settings\Toby\My Documents\My Virtual Machines\w2k server\drive-2.vmdk was closed
\[2006-03-20 19:37:13.250 'App' 1692 verbose] \[imageProcessingTaskWrapper,697] Task completed.
The "Server" has 3 virtual HDD's with a combination of multiple software RAID sets - is this relevant in any way. The virtual C:\ drive on the "Server" is mirrored through software RAID.
Any help is appreciated!
Just had a thought; could it be to do with the "dynamically expanding" disk feature in VPC? I am certain my w2k pro guest had a static disk (which converted OK) but I know my w2k Server guest has a dynamically expanding disk...a convert to static option in VPC wants to use the max size I specified when creating the disk but I don't really want to do this...
