VMware Cloud Community
jefftag
Contributor
Contributor

VMware 5.5: Error Unable to clone volume D

So i am trying to do a p2v of a server 2003r2x86 - it seems to have clone the c drive just fine, but the d drive fails, below are some screen shots and error logs - any insight would be greatly appricated.

----------------

Section for VMware vCenter Converter Standalone, pid=1884, version=5.5.1, build=1682692, option=Release

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] Logging uses fast path: true

2014-06-25T10:16:32.875-04:00 [01132 info 'Libs'] VThreadBase detected multiple threads.

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] Handling bora/lib logs with VmaCore facilities

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] Initialized channel manager

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] Current working directory: C:\Program Files\VMware\VMware vCenter Converter Standalone

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] ThreadPool windowsStackImmediateCommit = true

2014-06-25T10:16:32.875-04:00 [01308 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:32.875-04:00 [01132 info 'ThreadPool'] Thread pool on asio: Min Io, Max Io, Min Task, Max Task, Max Concurency: 1, 121, 2, 60, 2147483647

2014-06-25T10:16:32.875-04:00 [01132 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:32.875-04:00 [00904 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:32.875-04:00 [02012 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:32.875-04:00 [01132 info 'Default'] Trying converter_server

2014-06-25T10:16:34.593-04:00 [01132 info 'Default'] Trying ufa_agent

2014-06-25T10:16:34.921-04:00 [01132 info 'Default'] [shutdownMgr,25] Ufa shutdown manager registered.

2014-06-25T10:16:34.968-04:00 [01132 info 'Default'] [helper,454] Initializing SSL Contexts

2014-06-25T10:16:35.562-04:00 [01132 info 'Default'] Vmacore::InitSSL: handshakeTimeoutUs = 20000000

2014-06-25T10:16:35.671-04:00 [01132 info 'Default'] [helper,507] Initializing certificates

2014-06-25T10:16:35.718-04:00 [01132 info 'Default'] [task,2069] [LRO] 32 max LROs

2014-06-25T10:16:35.718-04:00 [01132 info 'Default'] [task,2071] [LRO] 6 reserved internal LROs

2014-06-25T10:16:35.718-04:00 [01132 info 'Default'] [task,2073] [LRO] 6 reserved short LROs

2014-06-25T10:16:35.718-04:00 [01132 info 'Default'] [task,2075] [LRO] 12 reserved long LROs

2014-06-25T10:16:35.718-04:00 [01132 info 'Default'] [task,2087] [LRO] 86400-second task lifetime

2014-06-25T10:16:35.953-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\) locale (en) removeable (false) resmap (02610d38) extKeys (00000000) (

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'hi_IN' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\iso2win.vlcl', only first one is used

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'az_AZ' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\iso2win.vlcl', only first one is used

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'sr_SP' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\iso2win.vlcl', only first one is used

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'az_AZ' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\isodata.vlcl', only first one is used

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'sr_SP' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\isodata.vlcl', only first one is used

2014-06-25T10:16:36.078-04:00 [01132 warning 'Locale'] Duplicate key 'uz_UZ' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\isodata.vlcl', only first one is used

2014-06-25T10:16:36.140-04:00 [01132 info 'Locale'] Added locale path C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\ to locale map

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (de) removeable (false) resmap (02627188) extKeys (00000000) (

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (en) removeable (false) resmap (02610d38) extKeys (00000000) (

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (fr) removeable (false) resmap (02629b00) extKeys (00000000) (

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (ja) removeable (false) resmap (02629cb8) extKeys (00000000) (

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (zh_CN) removeable (false) resmap (02629eb8) extKeys (00000000) (

2014-06-25T10:16:36.265-04:00 [01132 info 'Locale'] Added locale path C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\ to locale map

2014-06-25T10:16:37.406-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (de) removeable (false) resmap (02627188) extKeys (00000000) (

2014-06-25T10:16:37.406-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (en) removeable (false) resmap (02610d38) extKeys (00000000) (

2014-06-25T10:16:37.406-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (fr) removeable (false) resmap (02629b00) extKeys (00000000) (

2014-06-25T10:16:37.421-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (ja) removeable (false) resmap (02629cb8) extKeys (00000000) (

2014-06-25T10:16:37.421-04:00 [01132 info 'Locale'] Delay loading resources: path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (zh_CN) removeable (false) resmap (02629eb8) extKeys (00000000) (

2014-06-25T10:16:37.421-04:00 [01132 info 'Locale'] Added locale path C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\ to locale map

2014-06-25T10:16:37.421-04:00 [01132 info 'Locale'] Locale subsystem initialized from C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\ with default locale en.

2014-06-25T10:16:37.421-04:00 [01132 info 'Locale'] LoadResources path (C:\Program Files\VMware\VMware vCenter Converter Standalone\locale\) locale (en) removeable (false) resMap (02610d38) extKeys (00000000)

2014-06-25T10:16:37.500-04:00 [01132 info 'Locale'] LoadResources path (C:\Program Files\VMware\VMware vCenter Converter Standalone\coreLocale\) locale (en) removeable (false) resMap (02610d38) extKeys (00000000)

2014-06-25T10:16:37.515-04:00 [01132 info 'Locale'] LoadResources path (C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\) locale (en) removeable (false) resMap (02610d38) extKeys (00000000)

2014-06-25T10:16:37.671-04:00 [01132 warning 'Locale'] Duplicate key 'LicenseManager.LicenseInfo.vaai.label' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/default.vmsg', only first one is used

2014-06-25T10:16:37.671-04:00 [01132 warning 'Locale'] Duplicate key 'LicenseManager.LicenseInfo.vaai.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/default.vmsg', only first one is used

2014-06-25T10:16:37.703-04:00 [01132 warning 'Locale'] Duplicate key 'com.vmware.vim.license.Feature.vaai.label' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.703-04:00 [01132 warning 'Locale'] Duplicate key 'com.vmware.vim.license.Feature.vaai.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOWNative.label' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOWNative.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOW32.label' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOW32.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOW64.label' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.guest.WindowsRegistryManager.RegistryKeyName.RegistryKeyWowBitness.WOW64.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.GuestInfo.AppStateType.none.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.718-04:00 [01132 warning 'Locale'] Duplicate key 'vm.GuestInfo.AppStateType.none.summary' in file 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/enum.vmsg', only first one is used

2014-06-25T10:16:37.859-04:00 [01132 warning 'Locale'] 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/eventaux.vmsg', line 2629: Invalid message '               A virtual machine has a CPU, memory, and/or vFlash cache         reservation and no compatible host had enough resources to satisfy         the reservation(s).            </description>            <action>Decrease the virtual machine resource reservation</action>            <action>Add more host(s) to cluster</action>            <action>Bring online any failed hosts or resolve a network partition if one exists</action>            <action>If DRS is in manual mode, look for any pending recommendations             and approve them so that vSphere HA failover can proceed</action>        </cause>        <cause>            <description>        The cluster has vCloud Distributed Storage enabled, and one or more hosts that contribute storage               to the cluster is inaccessible, preventing vSphere HA from powering on the virtual machine.               This applies to virtual machines that have one or more files on a vCloud Distributed                Storage datastore.            </description>            <action>Bring online any failed hosts or resolve a network partition if one             exists that involves hosts that contribute storage to the vCloud Distributed             Storage cluster</action>        </cause>    </EventLongDescription>    "'

2014-06-25T10:16:38.671-04:00 [01132 warning 'Locale'] Key 'Internal.Tasks.SingleSpacedList' in module 'task' under 'C:\Program Files\VMware\VMware vCenter Converter Standalone\vimLocale\en/' was previously defined; ignored

2014-06-25T10:16:39.578-04:00 [01132 info 'Libs'] [ADS] Running on PDC

2014-06-25T10:16:39.578-04:00 [01132 info 'Libs'] [ADS] Local Domain :

2014-06-25T10:16:39.578-04:00 [01132 info 'Libs'] [ADS] IsWorkgroup: No

2014-06-25T10:16:39.578-04:00 [01132 info 'Libs'] [ADS] Local Machine:

2014-06-25T10:16:40.453-04:00 [01132 info 'Default'] BaseScheduler initialization complete -- void __thiscall Converter::Server::Scheduler::BaseScheduler::Initialize(const class boost::shared_ptr<class Converter::Server::Scheduler::SchedulerEnv>,const class boost::optional<class Converter::Server::Scheduler::SchedulerConstraints const &> &,const class boost::optional<class Converter::VdbConnection &> &) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/baseScheduler.cpp:112")

2014-06-25T10:16:40.468-04:00 [01132 info 'Default'] Loaded all items from the scheduler's database tables. -- void __thiscall Converter::Server::Scheduler::BaseScheduler::LoadSchedulerItemIdMap(void) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/baseScheduler.cpp:70")

2014-06-25T10:16:40.468-04:00 [01132 info 'Default'] Loaded all items from scheduler's database tables.Scheduler's item map contains 0 items. -- void __thiscall Converter::Server::Scheduler::PriorityQScheduler::LoadPriorityQ(void) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/priorityQScheduler.cpp:185")

2014-06-25T10:16:40.468-04:00 [01132 info 'Default'] [plugin,158] ServerPlugin Init

2014-06-25T10:16:40.468-04:00 [01132 info 'Ufa'] Initializing SSL context

2014-06-25T10:16:40.468-04:00 [01132 info 'Ufa'] Plugin initialized

2014-06-25T10:16:40.500-04:00 [04704 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:40.500-04:00 [04704 info 'Default'] [task,338] [task-internal-1] -- BEGIN -- TaskManager

2014-06-25T10:16:40.500-04:00 [04708 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:40.500-04:00 [04712 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:40.500-04:00 [01132 info 'Default'] [plugin,188] ServerPlugin Start

2014-06-25T10:16:40.500-04:00 [04716 info 'ThreadPool'] Thread enlisted

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa'] SOAP pipe name: \\.\pipe\vmware-converter-server-soap

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa.HTTPService'] Setting buffer size to 32768

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa.HTTPService'] Using default for nonChunkingAgents: 'VMware VI Client|VMware-client|VMware-client/3.*'

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa.HTTPService'] Using default for agentsNeedingContentLength: 'VMware-client'

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa.HTTPService'] Max buffered response size is 104857600 bytes

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa'] enableChunkedResponses: true

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa.HTTPService'] Http Service started: <server p:0x0352bf38, '\\.\pipe\vmware-converter-server-soap'>

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa'] Soap (over Named Pipe) started on pipe \\.\pipe\vmware-converter-server-soap. enableRemoteAccess = false, nonRootAccess = true, useSSL = false

2014-06-25T10:16:40.500-04:00 [01132 info 'Ufa'] Plugin started

2014-06-25T10:16:40.500-04:00 [01132 info 'Default'] Running on OS: Windows Server 2003 Standard Edition Service Pack 2 (Build 3790); CPUs: 8

2014-06-25T10:16:40.500-04:00 [01132 info 'Default'] [serviceWin32,416] vmware-converter-server service started

2014-06-25T11:43:25.750-04:00 [01132 info 'Default'] [user,874] Successfully authenticated user \TBNG from this local machine (using pipe)

2014-06-25T11:43:29.031-04:00 [01132 info 'Default'] [user,874] Successfully authenticated user \TBNG from this local machine (using pipe)

2014-06-25T11:44:15.687-04:00 [00904 error 'Ufa.HTTPService'] Failed to read request; stream: <io_obj p:0x0354a2bc, h:-1, <pipe '\\.\pipe\vmware-converter-server-soap'>, <pipe '\\.\pipe\vmware-converter-server-soap'>>, error: class Vmacore::TimeoutException(Operation timed out)

2014-06-25T11:46:28.968-04:00 [01132 info 'Default'] === [Converter::Server::Conversion::ConversionManagerImpl::CreateJob] ConversionJobSpec:

--> (converter.server.conversion.ConversionJobSpec) {

-->    dynamicType = <unset>,

-->    name = "ConversionJob_52faf5b2-7eb8-5aeb-3071-361cce4cbdbe",

-->    description = <unset>,

-->    firstRun = <unset>,

-->    startSuspended = <unset>,

-->    source = (converter.ComputerSpec) {

-->       dynamicType = <unset>,

-->       location = (converter.ComputerSpec.LiveComputerLocation) {

-->          dynamicType = <unset>,

-->          hostname = "",

-->          port = <unset>,

-->          username = <unset>,

-->          password = <unset>,

-->          osType = "windowsOs",

-->          verifyPeer = <unset>,

-->          sslThumbprint = <unset>,

-->       },

-->    },

-->    conversionParams = (converter.params.ConversionParams) {

-->       dynamicType = <unset>,

-->       osInstanceBootLoaderEntry = (converter.info.BootConfigInfo.BootLoaderEntrySpec) null,

-->       doClone = true,

-->       cloningParams = (converter.params.CloningParams) {

-->          dynamicType = <unset>,

-->          target = (converter.params.TargetVmSpec) {

-->             dynamicType = <unset>,

-->             name = "profileserver.",

-->             location = (converter.params.TargetVmSpec.ManagedVmLocation) {

-->                dynamicType = <unset>,

-->                vimConnect = (converter.VimConnectionSpec) {

-->                   dynamicType = <unset>,

-->                   hostname = "10.11.50.11",

-->                   port = <unset>,

-->                   credentials = (converter.VimConnectionSpec.LoginVimCredentials) {

-->                      dynamicType = <unset>,

-->                      username = "root",

-->                      password = (not shown),

-->                   },

-->                   verifyPeer = <unset>,

-->                   sslThumbprint = "74:81:76:B8:7B:6E:E0:6B:81:BB:29:7B:3C:01:E8:E9:DF:F3:D4:C5",

-->                },

-->                vmFolder = <unset>,

-->                host = 'vim.HostSystem:ha-host',

-->                resourcePool = <unset>,

-->                computeResource = <unset>,

-->                vmFolderName = <unset>,

-->                hostName = "FWMS-ESXi-01",

-->                resourcePoolName = <unset>,

-->                computeResourceName = <unset>,

-->             },

-->             productVersion = <unset>,

-->             hardwareVersion = "vmx-09",

-->          },

-->          storageParams = (converter.params.StorageParams) {

-->             dynamicType = <unset>,

-->             cloningMode = "volumeBasedCloning",

-->             diskControllerType = "scsiLsiLogic",

-->             targetDiskParams = (converter.params.StorageParams.TargetDiskParams) [

-->                (converter.params.StorageParams.ManagedTargetDiskParams) {

-->                   dynamicType = <unset>,

-->                   sourceDiskId = "disk-1002",

-->                   volumesToClone = (converter.params.StorageParams.VolumeCloningParams) [

-->                      (converter.params.StorageParams.VolumeCloningParams) {

-->                         dynamicType = <unset>,

-->                         sourceVolumeId = "\WindowsBitmapDriverVolumeId=[D9-98-56-34-00-00-10-00-00-00-00-00]",

-->                         resize = true,

-->                         newCapacityInBytes = 85899345920,

-->                         newClusterSizeInBytes = <unset>,

-->                      },

-->                      (converter.params.StorageParams.VolumeCloningParams) {

-->                         dynamicType = <unset>,

-->                         sourceVolumeId = "\WindowsBitmapDriverVolumeId=[D9-98-56-34-00-00-70-00-08-00-00-00]",

-->                         resize = false,

-->                         newCapacityInBytes = <unset>,

-->                         newClusterSizeInBytes = <unset>,

-->                      }

-->                   ],

-->                   diskType = "vmfsMonolithicFlat",

-->                   lvg = false,

-->                   gpt = false,

-->                   datastoreName = "datastore1",

-->                }

-->             ],

-->             skipUnwantedFiles = true,

-->             useBitmapDriver = <unset>,

-->             intermediateImage = <unset>,

-->             modifiedClustersOnly = <unset>,

-->             vmxDatastoreName = "datastore1",

-->             resizeRatio = <unset>,

-->             minVolumeSize = <unset>,

-->             optimizedPartitionAlignment = true,

-->          },

-->          networkParams = (converter.params.NetworkParams) {

-->             dynamicType = <unset>,

-->             preserveNicCount = true,

-->             preserveNicMapping = false,

-->             nic = (converter.params.NetworkParams.NicParams) [

-->                (converter.params.NetworkParams.ManagedNicParams) {

-->                   dynamicType = <unset>,

-->                   connected = true,

-->                   networkName = "VM Network",

-->                   nicControllerType = <unset>,

-->                }

-->             ],

-->          },

-->          basicHardwareParams = (converter.params.BasicHardwareParams) {

-->             dynamicType = <unset>,

-->             numCPUs = 4,

-->             numCoresPerSocket = 4,

-->             memoryMB = 4092,

-->          },

-->          incrementalP2VCloningParams = (converter.params.IncrementalP2VCloningParams) null,

-->          nextBitmapId = <unset>,

-->          snapshotSource = <unset>,

-->          preserveDeviceBacking = <unset>,

-->          preserveIdentity = <unset>,

-->          doSynchronize = false,

-->          doFinalize = <unset>,

-->          ovfParams = (converter.params.OvfParams) null,

-->          retainLimit = <unset>,

-->       },

-->       doReconfig = true,

-->       reconfigParams = (converter.params.ReconfigParams) null,

-->       doSynchronize = <unset>,

-->       doInstallTools = false,

-->       doCustomize = <unset>,

-->       customizationParams = (converter.params.CustomizationParams) null,

-->       doUninstallAgent = false,

-->       powerOnTargetVM = false,

-->       removeRestoreCheckpoints = true,

-->       helperVmNetworkParams = (converter.params.HelperVmNetworkParams) null,

-->       throttlingParams = (converter.params.ThrottlingParams) {

-->          dynamicType = <unset>,

-->          cpuThrottling = "none",

-->          networkBandwidthThrottlingInMB = <unset>,

-->       },

-->    },

-->    p2vSourceModificationSpec = (converter.server.conversion.P2VSourceModificationSpec) null,

-->    parentFolder = 'converter.server.conversion.ConversionFolder:ConversionFolder',

-->    synchronizeImmediately = <unset>,

-->    synchronizationStartTime = <unset>,

--> }

--> =====================

2014-06-25T11:47:24.125-04:00 [01132 info 'Default'] Connecting to host 10.11.50.11 on port 443

2014-06-25T11:47:24.125-04:00 [01132 info 'Default'] localVersion is: vim.version.version9

2014-06-25T11:47:24.203-04:00 [01132 info 'Default'] Remote version is: vim.version.version9

2014-06-25T11:47:24.203-04:00 [01132 info 'Default'] Authenticating user root

2014-06-25T11:47:24.296-04:00 [01132 info 'Default'] ComputeResource for vim.HostSystem:ha-host is vim.ComputeResource:ha-compute-res

2014-06-25T11:47:24.296-04:00 [01132 info 'Default'] ResourcePool for vim.ComputeResource:ha-compute-res is vim.ResourcePool:ha-root-pool

2014-06-25T11:47:24.296-04:00 [01132 info 'Default'] ComputeResource for vim.ResourcePool:ha-root-pool is vim.ComputeResource:ha-compute-res

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] Datacenter for vim.ComputeResource:ha-compute-res is vim.Datacenter:ha-datacenter

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] Root VM folder for vim.Datacenter:ha-datacenter is vim.Folder:ha-folder-vm

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] Reusing existing VIM connection to 10.11.50.11

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] Scheduled timer canceled, StopKeepAlive succeeds

2014-06-25T11:47:24.312-04:00 [01132 info 'vmomi.soapStub[1]'] Resetting stub adapter for server <cs p:035784d8, TCP:10.11.50.11:443> : Closed

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] Connecting to host 10.11.50.11 on port 443

2014-06-25T11:47:24.312-04:00 [01132 info 'Default'] localVersion is: vim.version.version9

2014-06-25T11:47:24.343-04:00 [01132 info 'Default'] Remote version is: vim.version.version9

2014-06-25T11:47:24.343-04:00 [01132 info 'Default'] Authenticating user root

2014-06-25T11:47:24.421-04:00 [01132 info 'Default'] Scheduled timer canceled, StopKeepAlive succeeds

2014-06-25T11:47:24.437-04:00 [01132 info 'Default'] ComputeResource for vim.ResourcePool:ha-root-pool is vim.ComputeResource:ha-compute-res

2014-06-25T11:47:24.500-04:00 [01132 info 'vmomi.soapStub[2]'] Resetting stub adapter for server <cs p:03579ee8, TCP:10.11.50.11:443> : Closed

2014-06-25T11:47:24.500-04:00 [01132 info 'Default'] Created new scheduler item with id = "1", firstTimeToRun = "2014-06-25 11:47:24.312", source = "", targetRPOInMinutes = "0". -- __thiscall Converter::Server::Scheduler::SchedulerItemImpl::SchedulerItemImpl(const class Converter::Server::Scheduler::SchedulerItemSpec &,const int &,const class boost::shared_ptr<class Converter::Server::Scheduler::SchedulerEnv> &,const class Vmacore::Ref<class Vmacore::Service::Logger> &,const class boost::optional<class Converter::VdbConnection &> &) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/schedulerItemImpl.cpp:87")

2014-06-25T11:47:24.500-04:00 [01132 info 'Default'] scheduler item with id="1" created -- int __thiscall Converter::Server::Scheduler::PriorityQScheduler::AddSchedulerItem(const class boost::shared_ptr<class Converter::Server::Scheduler::SchedulerItemSpec> &,const class boost::optional<class Converter::VdbConnection &> &) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/priorityQScheduler.cpp:49")

2014-06-25T11:47:24.515-04:00 [04708 info 'Default'] Scheduler scheduling item 1 to run at time = 2014-06-25 11:47:24.515. -- void __thiscall Converter::Server::Scheduler::SimpleScheduler::Run(void) ("d:/build/ob/bora-1682692/bora/sysimage/ufad/server/scheduler/simpleScheduler.cpp:109")

2014-06-25T11:47:24.531-04:00 [04716 info 'Default'] Connecting to host 10.11.50.11 on port 443

2014-06-25T11:47:24.531-04:00 [04716 info 'Default'] localVersion is: vim.version.version9

2014-06-25T11:47:24.546-04:00 [04716 info 'Default'] Remote version is: vim.version.version9

2014-06-25T11:47:24.546-04:00 [04716 info 'Default'] Authenticating user root

2014-06-25T11:47:24.640-04:00 [00904 info 'Default'] ConverterConnection: KeepAlive timer canceled, StopKeepAlive succeeded

2014-06-25T11:47:24.640-04:00 [00904 info 'vmomi.soapStub[0]'] Resetting stub adapter for server <cs p:03569ad0, PIPE:\\.\pipe\vmware-converter-worker-soap> : Closed

2014-06-25T11:47:24.640-04:00 [04716 info 'Default'] ComputeResource for vim.HostSystem:ha-host is vim.ComputeResource:ha-compute-res

2014-06-25T11:47:24.640-04:00 [04716 info 'Default'] ResourcePool for vim.ComputeResource:ha-compute-res is vim.ResourcePool:ha-root-pool

2014-06-25T11:47:24.640-04:00 [04716 info 'Default'] ComputeResource for vim.ResourcePool:ha-root-pool is vim.ComputeResource:ha-compute-res

2014-06-25T11:47:24.656-04:00 [04716 info 'Default'] Datacenter for vim.ComputeResource:ha-compute-res is vim.Datacenter:ha-datacenter

2014-06-25T11:47:24.656-04:00 [04716 info 'Default'] Root VM folder for vim.Datacenter:ha-datacenter is vim.Folder:ha-folder-vm

2014-06-25T11:47:24.656-04:00 [04716 info 'Default'] Reusing existing VIM connection to 10.11.50.11

2014-06-25T11:47:24.671-04:00 [04716 info 'Default'] Scheduled timer canceled, StopKeepAlive succeeds

2014-06-25T11:47:24.671-04:00 [04716 info 'vmomi.soapStub[3]'] Resetting stub adapter for server <cs p:0352ada8, TCP:10.11.50.11:443> : Closed

2014-06-25T11:47:24.750-04:00 [07172 info 'ThreadPool'] Thread enlisted

2014-06-25T11:47:24.765-04:00 [04716 info 'Default'] Started task "task-1" for job="job-1", item ="1" -- void __thiscall Converter::Server::Job::JobProcessorImpl::StartProcessingJobs(void) ("d:/build/ob/bora-1682692/bora/sysimage/lib/converter/server/job/jobProcessorImpl.cpp:385")

2014-06-25T11:47:24.781-04:00 [07172 info 'Default'] [task,338] [task-1] -- BEGIN -- Convert

2014-06-25T11:47:24.796-04:00 [07172 info 'Default'] [taskSpec,472] [task-1] [TaskMap] task-1:task-1

2014-06-25T11:47:24.796-04:00 [05604 info 'ThreadPool'] Thread enlisted

2014-06-25T12:07:00.828-04:00 [02012 error 'Ufa.HTTPService'] Failed to read request; stream: <io_obj p:0x03559b64, h:-1, <pipe '\\.\pipe\vmware-converter-server-soap'>, <pipe '\\.\pipe\vmware-converter-server-soap'>>, error: class Vmacore::TimeoutException(Operation timed out)

2014-06-25T12:07:25.828-04:00 [00904 error 'Ufa.HTTPService'] Failed to read request; stream: <io_obj p:0x03569354, h:-1, <pipe '\\.\pipe\vmware-converter-server-soap'>, <pipe '\\.\pipe\vmware-converter-server-soap'>>, error: class Vmacore::TimeoutException(Operation timed out)

2014-06-25T22:01:21.968-04:00 [07172 error 'Default'] [task,350] [LRO] Unexpected Exception: converter.fault.CloneFault

2014-06-25T22:01:22.140-04:00 [07172 info 'Default'] [task,379] [task-1] -- ERROR -- Convert: converter.fault.CloneFault

--> (converter.fault.CloneFault) {

-->    dynamicType = <unset>,

-->    faultCause = (vmodl.MethodFault) null,

-->    description = "converter.fault.FileIOFault",

-->    msg = "",

--> }

2014-06-25T22:01:22.156-04:00 [07172 info 'Default'] [diagnosticManager,269] Retrieved taskInfo for "converter.task.Task:task-1" mapping it to "converter.task.Task:task-1".

2014-06-25T22:01:22.156-04:00 [07172 info 'Default'] [diagnosticManager,309] The task with id = "task-1" was found to be a "recent" task.

2014-06-25T22:01:22.156-04:00 [07172 info 'Default'] [diagnosticManager,323] No existing log bundle found for task with id = "task-1". The task is still "recent" so a log bundle will now be generated for it.

2014-06-25T22:01:22.156-04:00 [07172 info 'Default'] [diagnosticManager,1052] Retrieving task related diagnostics for server task with id = "task-1".

2014-06-25T22:01:22.437-04:00 [04712 info 'Default'] Run 0 of job "job-1" finished with an error. -- struct Converter::Server::Job::JobExecutor::SchedulerUpdateSpec __thiscall Converter::Server::Conversion::ConversionJobExecutorImpl::UpdateJob(class Converter::Server::Job::InternalJob &,bool,const class Converter::Server::Scheduler::SchedulerItemStatistics &,const class Converter::Task::TaskInfo &) ("d:/build/ob/bora-1682692/bora/sysimage/lib/converter/server/conversion/conversionJobExecutorImpl.cpp:405")

2014-06-25T22:01:22.593-04:00 [04712 info 'Default'] Suspended 1 scheduler items for job (job-1) -- void __thiscall Converter::Server::Job::JobProcessorImpl::SuspendJobAux(const class Converter::Server::Job::InternalJob &,class Converter::VdbConnection &) ("d:/build/ob/bora-1682692/bora/sysimage/lib/converter/server/job/jobProcessorImpl.cpp:830")

0 Kudos
5 Replies
POCEH
VMware Employee
VMware Employee

The exact error must be in converter-worker.log if you couldn't find it - upload log bundle.

0 Kudos
jefftag
Contributor
Contributor


attached, thanks again

0 Kudos
POCEH
VMware Employee
VMware Employee

The error is

2014-06-25T22:00:51.796-04:00 [04108 error 'task-2'] BlockLevelVolumeCloneMgr::ReadAndSkipBadBlocks(): Error (type: 2, code: 1117) reading 655360 bytes starting at 0x0000004f865e0000 from the source volume 😧
2014-06-25T22:00:51.796-04:00 [04108 error 'task-2'] BlockLevelVolumeCloneMgr::ReadAndSkipBadBlocks(): Unrecoverable error (type: 2, code: 1117) reading 655360 bytes starting from 0x0000004f865e0000 from the source volume 😧 2014-06-25T22:00:51.828-04:00 [04108 error 'task-2'] BlockLevelVolumeCloneMgr::CloneVolume: failed with exception converter.fault.FileIOFault

You should run 'chkdsk d: /b' command and then try again the conversion.

HTH

0 Kudos
patanassov
VMware Employee
VMware Employee

The error is

Converter::AtomicVssVolumeSnapshotSet::DeleteSnapshotSet: VSS snapshot failed: Unable to create a snapshot for volume \\.\Volume{c248b111-3281-11e2-8bdf-806e6f6e6963}, \\.\Volume{45086034-802f-11e2-8832-806e6f6e6963}. Error code 2147754760 (0x80042308)

See here for more details:
https://secure.efoldering.com/support/index.php?/Knowledgebase/Article/View/60/6/vss-error-vss_e_obj...

HTH

Plamen

0 Kudos
JPM300
Commander
Commander

hey,

I don't think this is the issue with your particular VM as it seems its more related to the chkdsk problem, however I figured I would mention this.  On Windows Server 2003 P2V's I have ran into this one a few times:

http://kb.vmware.com/selfservice/microsites/search.do?language=en_US&cmd=displayKC&externalId=103014...

If you have the /3GB switch in your boot.ini it can cause problems and has to be removed.  Just figured I would through this out there.

Good luck!

0 Kudos