-----------------------------------------------------------
This is an automatically generated e-mail. To reply, visit:
https://reviews.apache.org/r/29087/#review65190
-----------------------------------------------------------


I'm getting this error when trying to run with the latest 4.4 branch:

2014-12-16 11:01:41,025 DEBUG [c.c.v.VmWorkJobDispatcher] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70) Run VM work job: 
com.cloud.vm.VmWorkStart for VM 1, job origin: 20
2014-12-16 11:01:41,027 DEBUG [c.c.v.VmWorkJobHandlerProxy] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Execute VM work 
job: 
com.cloud.vm.VmWorkStart{"dcId":0,"userId":1,"accountId":1,"vmId":1,"handlerName":"VirtualMachineManagerImpl"}
2014-12-16 11:01:41,035 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) VM state 
transitted from :Stopped to Starting with event: StartRequestedvm's original 
host id: null new host id: null host id before state transition: null
2014-12-16 11:01:41,035 DEBUG [c.c.v.VirtualMachineManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Successfully 
transitioned to start state for VM[ConsoleProxy|v-1-VM] reservation id = 
efd0d2cc-cc6f-44b3-b373-e8f0ecf3e33e
2014-12-16 11:01:41,039 DEBUG [c.c.v.VirtualMachineManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Trying to deploy 
VM, vm has dcId: 1 and podId: 1
2014-12-16 11:01:41,039 DEBUG [c.c.v.VirtualMachineManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Deploy avoids 
pods: null, clusters: null, hosts: null
2014-12-16 11:01:41,043 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Deploy avoids 
pods: null, clusters: null, hosts: null
2014-12-16 11:01:41,044 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) 
DeploymentPlanner allocation algorithm: 
com.cloud.deploy.FirstFitPlanner@663f6fad
2014-12-16 11:01:41,044 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Trying to 
allocate a host and storage pools from dc:1, pod:1,cluster:null, requested cpu: 
500, requested ram: 1073741824
2014-12-16 11:01:41,044 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Is ROOT volume 
READY (pool already allocated)?: No
2014-12-16 11:01:41,044 DEBUG [c.c.d.FirstFitPlanner] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Searching 
resources only under specified Pod: 1
2014-12-16 11:01:41,045 DEBUG [c.c.d.FirstFitPlanner] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Listing clusters 
in order of aggregate capacity, that have (atleast one host with) enough CPU 
and RAM capacity under this Pod: 1
2014-12-16 11:01:41,054 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking 
resources in Cluster: 1 under Pod: 1
2014-12-16 11:01:41,054 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Looking for hosts in dc: 1  pod:1  cluster:1
2014-12-16 11:01:41,057 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for 
allocation: [Host[-1-Routing]]
2014-12-16 11:01:41,061 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: 
[Host[-1-Routing]]
2014-12-16 11:01:41,062 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Looking for speed=500Mhz, Ram=1024
2014-12-16 11:01:41,068 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Host: 1 has cpu capability (cpu:2, speed:2399) to 
support requested CPU: 1 and requested speed: 500
2014-12-16 11:01:41,068 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested 
CPU: 500 and requested RAM: 1073741824 , cpuOverprovisioningFactor: 1.0
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Hosts's actual total CPU: 4798 and CPU after applying 
overprovisioning: 4798
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Free CPU: 4298 , Requested CPU: 500
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Free RAM: 6890268672 , Requested RAM: 1073741824
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Host has enough CPU and RAM available
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 500, 
reserved: 0, actual total: 4798, total with overprovisioning: 4798; requested 
cpu:500,alloc_from_last_host?:false ,considerReservedCapacity?: true
2014-12-16 11:01:41,071 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 536870912, 
reserved: 0, total: 7427139584; requested mem: 
1073741824,alloc_from_last_host?:false ,considerReservedCapacity?: true
2014-12-16 11:01:41,071 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Found a suitable host, adding to list: 1
2014-12-16 11:01:41,071 DEBUG [c.c.a.m.a.i.FirstFitAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137 
FirstFitRoutingAllocator) Host Allocator returning 1 suitable hosts
2014-12-16 11:01:41,073 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking 
suitable pools for volume (Id, Type): (1,ROOT)
2014-12-16 11:01:41,073 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) We need to 
allocate new storagepool for this volume
2014-12-16 11:01:41,074 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Calling 
StoragePoolAllocators to find suitable pools
2014-12-16 11:01:41,075 DEBUG [o.a.c.s.a.LocalStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) 
LocalStoragePoolAllocator trying to find storage pool to fit the vm
2014-12-16 11:01:41,075 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) 
ClusterScopeStoragePoolAllocator looking for storage pool
2014-12-16 11:01:41,075 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Looking for 
pools in dc: 1  pod:1  cluster:1
2014-12-16 11:01:41,077 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Found pools 
matching tags: [Pool[2|NetworkFilesystem]]
2014-12-16 11:01:41,078 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Removing pool 
Pool[2|NetworkFilesystem] from avoid set, must have been inserted when 
searching for another disk's tag
2014-12-16 11:01:41,080 DEBUG [o.a.c.s.a.AbstractStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking if 
storage pool is suitable, name: null ,poolId: 2
2014-12-16 11:01:41,083 DEBUG [c.c.s.StorageManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking pool 2 
for storage, totalSize: 32615956480, usedBytes: 7256670208, usedPct: 
0.22248834592509242, disable threshold: 0.85
2014-12-16 11:01:41,089 DEBUG [c.c.s.StorageManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Found storage 
pool nfs of type NetworkFilesystem with overprovisioning factor 2
2014-12-16 11:01:41,089 DEBUG [c.c.s.StorageManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Total over 
provisioned capacity calculated is 2 * 32615956480
2014-12-16 11:01:41,089 DEBUG [c.c.s.StorageManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Total capacity 
of the pool nfs id: 2 is 65231912960
2014-12-16 11:01:41,090 DEBUG [c.c.s.StorageManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking pool: 2 
for volume allocation [Vol[1|vm=1|ROOT]], maxSize : 65231912960, 
totalAllocatedSize : 0, askingSize : 0, allocated disable threshold: 0.85
2014-12-16 11:01:41,090 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) 
ClusterScopeStoragePoolAllocator returning 1 suitable storage pools
2014-12-16 11:01:41,090 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Trying to find a 
potenial host and associated storage pools from the suitable host/pool lists 
for this VM
2014-12-16 11:01:41,090 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking if 
host: 1 can access any suitable storage pool for volume: ROOT
2014-12-16 11:01:41,091 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Host: 1 can 
access pool: 2
2014-12-16 11:01:41,092 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Found a 
potential host id: 1 name: acs-xenresize-xen01 and associated storage pools for 
this VM
2014-12-16 11:01:41,093 DEBUG [c.c.d.DeploymentPlanningManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Returning 
Deployment Destination: 
Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] 
: Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage(Volume(1|ROOT-->Pool(2))]
2014-12-16 11:01:41,093 DEBUG [c.c.v.VirtualMachineManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Deployment found 
 - P0=VM[ConsoleProxy|v-1-VM], 
P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))]
 : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage(Volume(1|ROOT-->Pool(2))]
2014-12-16 11:01:41,102 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) VM state 
transitted from :Starting to Starting with event: OperationRetryvm's original 
host id: null new host id: 1 host id before state transition: null
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Hosts's actual 
total CPU: 4798 and CPU after applying overprovisioning: 4798
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) We are 
allocating VM, increasing the used capacity of this host:1
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Current Used 
CPU: 500 , Free CPU:4298 ,Requested CPU: 500
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Current Used 
RAM: 536870912 , Free RAM:6890268672 ,Requested RAM: 1073741824
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) CPU STATS after 
allocation: for host: 1, old used: 500, old reserved: 0, actual total: 4798, 
total with overprovisioning: 4798; new used:1000, reserved:0; requested 
cpu:500,alloc_from_last:false
2014-12-16 11:01:41,109 DEBUG [c.c.c.CapacityManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) RAM STATS after 
allocation: for host: 1, old used: 536870912, old reserved: 0, total: 
7427139584; new used: 1610612736, reserved: 0; requested mem: 
1073741824,alloc_from_last:false
2014-12-16 11:01:41,112 DEBUG [c.c.v.VirtualMachineManagerImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) VM is being 
created in podId: 1
2014-12-16 11:01:41,121 DEBUG [o.a.c.e.o.NetworkOrchestrator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Network id=204 
is already implemented
2014-12-16 11:01:41,131 DEBUG [c.c.n.NetworkModelImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Service 
SecurityGroup is not supported in the network id=204
2014-12-16 11:01:41,142 DEBUG [o.a.c.e.o.NetworkOrchestrator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Asking 
VirtualRouter to prepare for 
Nic[1-1-efd0d2cc-cc6f-44b3-b373-e8f0ecf3e33e-10.18.252.120]
2014-12-16 11:01:41,143 DEBUG [c.c.n.NetworkModelImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Service 
SecurityGroup is not supported in the network id=204
2014-12-16 11:01:41,145 DEBUG [o.a.c.e.o.NetworkOrchestrator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Network id=202 
is already implemented
2014-12-16 11:01:41,168 DEBUG [o.a.c.e.o.NetworkOrchestrator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Network id=201 
is already implemented
2014-12-16 11:01:41,184 DEBUG [c.c.n.g.PodBasedNetworkGuru] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Allocated a nic 
NicProfile[3-1-efd0d2cc-cc6f-44b3-b373-e8f0ecf3e33e-10.18.252.108-null for 
VM[ConsoleProxy|v-1-VM]
2014-12-16 11:01:41,189 DEBUG [o.a.c.e.o.VolumeOrchestrator] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Checking if we 
need to prepare 1 volumes for VM[ConsoleProxy|v-1-VM]
2014-12-16 11:01:41,200 DEBUG [o.a.c.s.i.TemplateDataFactoryImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) template 1 is 
already in store:1, type:Image
2014-12-16 11:01:41,204 DEBUG [o.a.c.s.i.TemplateDataFactoryImpl] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) template 1 is 
already in store:2, type:Primary
2014-12-16 11:01:41,217 DEBUG [o.a.c.s.m.AncientDataMotionStrategy] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) copyAsync 
inspecting src type TEMPLATE copyAsync inspecting dest type VOLUME
2014-12-16 11:01:41,228 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Seq 
1-1590896568368627899: Sending  { Cmd , MgmtId: 345051613899, via: 
1(acs-xenresize-xen01), Ver: v1, Flags: 100011, 
[{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"5f6df867-86d8-449c-b1eb-ae8760c85a56","origUrl":"http://cloudstack.apt-get.eu/systemvm/4.4/systemvm64template-4.4.0-6-xen.vhd.bz2","uuid":"f29bbc9a-8504-11e4-ad06-005056adcacb","id":1,"format":"VHD","accountId":1,"checksum":"7a8a6c4f8478147f1c6aa0d20f5e62b9","hvm":false,"displayText":"SystemVM
 Template 
(XenServer)","imageDataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"1a215646-6057-3049-93d4-49bd238043c0","id":2,"poolType":"NetworkFilesystem","host":"10.18.252.40","path":"/primary","port":2049,"url":"NetworkFilesystem://10.18.252.40/primary/?ROLE=Primary&STOREUUID=1a215646-6057-3049-93d4-49bd238043c0"}},"name
 
":"routing-1","hypervisorType":"XenServer"}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"f33e06ec-05e0-4263-85ff-4cbce73f03ab","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"1a215646-6057-3049-93d4-49bd238043c0","id":2,"poolType":"NetworkFilesystem","host":"10.18.252.40","path":"/primary","port":2049,"url":"NetworkFilesystem://10.18.252.40/primary/?ROLE=Primary&STOREUUID=1a215646-6057-3049-93d4-49bd238043c0"}},"name":"ROOT-1","size":0,"volumeId":1,"vmName":"v-1-VM","accountId":1,"format":"VHD","id":1,"deviceId":0,"hypervisorType":"XenServer"}},"executeInSequence":false,"options":{},"wait":0}}]
 }
2014-12-16 11:01:41,230 DEBUG [c.c.a.t.Request] 
(Work-Job-Executor-49:ctx-49d1b9c2 job-20/job-70 ctx-59a62137) Seq 
1-1590896568368627899: Executing:  { Cmd , MgmtId: 345051613899, via: 
1(acs-xenresize-xen01), Ver: v1, Flags: 100011, 
[{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"5f6df867-86d8-449c-b1eb-ae8760c85a56","origUrl":"http://cloudstack.apt-get.eu/systemvm/4.4/systemvm64template-4.4.0-6-xen.vhd.bz2","uuid":"f29bbc9a-8504-11e4-ad06-005056adcacb","id":1,"format":"VHD","accountId":1,"checksum":"7a8a6c4f8478147f1c6aa0d20f5e62b9","hvm":false,"displayText":"SystemVM
 Template 
(XenServer)","imageDataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"1a215646-6057-3049-93d4-49bd238043c0","id":2,"poolType":"NetworkFilesystem","host":"10.18.252.40","path":"/primary","port":2049,"url":"NetworkFilesystem://10.18.252.40/primary/?ROLE=Primary&STOREUUID=1a215646-6057-3049-93d4-49bd238043c0"}},"n
 
ame":"routing-1","hypervisorType":"XenServer"}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"f33e06ec-05e0-4263-85ff-4cbce73f03ab","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"1a215646-6057-3049-93d4-49bd238043c0","id":2,"poolType":"NetworkFilesystem","host":"10.18.252.40","path":"/primary","port":2049,"url":"NetworkFilesystem://10.18.252.40/primary/?ROLE=Primary&STOREUUID=1a215646-6057-3049-93d4-49bd238043c0"}},"name":"ROOT-1","size":0,"volumeId":1,"vmName":"v-1-VM","accountId":1,"format":"VHD","id":1,"deviceId":0,"hypervisorType":"XenServer"}},"executeInSequence":false,"options":{},"wait":0}}]
 }
2014-12-16 11:01:41,231 DEBUG [c.c.a.m.DirectAgentAttache] 
(DirectAgent-93:ctx-ee3cddb5) Seq 1-1590896568368627899: Executing request
2014-12-16 11:01:42,075 DEBUG [o.a.c.f.j.d.VmWorkJobDaoImpl] 
(Vm-Operations-Cleanup-1:ctx-4d47805f) Expunge completed work job-68
2014-12-16 11:01:42,079 DEBUG [o.a.c.f.j.d.VmWorkJobDaoImpl] 
(Vm-Operations-Cleanup-1:ctx-4d47805f) Expunge completed work job-69
2014-12-16 11:01:42,223 WARN  [c.c.h.x.r.XenServerStorageProcessor] 
(DirectAgent-93:ctx-ee3cddb5) Unable to create volume; 
Pool=volumeTO[uuid=f33e06ec-05e0-4263-85ff-4cbce73f03ab|path=null|datastore=PrimaryDataStoreTO[uuid=1a215646-6057-3049-93d4-49bd238043c0|name=null|id=2|pooltype=NetworkFilesystem]];
 Disk: 
SR_BACKEND_FAILURE_79VDI Invalid size [opterr=shrinking not allowed]
        at com.xensource.xenapi.Types.checkResponse(Types.java:2006)
        at com.xensource.xenapi.Connection.dispatch(Connection.java:350)
        at 
com.cloud.hypervisor.xen.resource.XenServerConnectionPool$XenServerConnection.dispatch(XenServerConnectionPool.java:456)
        at com.xensource.xenapi.VDI.resize(VDI.java:1226)
        at 
com.cloud.hypervisor.xen.resource.XenServerStorageProcessor.cloneVolumeFromBaseTemplate(XenServerStorageProcessor.java:1056)
        at 
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:81)
        at 
com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:52)
        at 
com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:542)
        at 
com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:61)
        at 
com.cloud.hypervisor.xen.resource.XenServer610Resource.executeRequest(XenServer610Resource.java:102)
        at 
com.cloud.agent.manager.DirectAgentAttache$Task.runInContext(DirectAgentAttache.java:307)
        at 
org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
        at 
org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
        at 
org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
        at 
org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
        at 
org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
        at java.util.concurrent.FutureTask.run(FutureTask.java:262)
        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:178)
        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:292)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
        at java.lang.Thread.run(Thread.java:745)

- Erik Weber


On Dec. 16, 2014, 6:07 a.m., Yitao Jiang wrote:
> 
> -----------------------------------------------------------
> This is an automatically generated e-mail. To reply, visit:
> https://reviews.apache.org/r/29087/
> -----------------------------------------------------------
> 
> (Updated Dec. 16, 2014, 6:07 a.m.)
> 
> 
> Review request for cloudstack, Mike Tutkowski and Min Chen.
> 
> 
> Repository: cloudstack-git
> 
> 
> Description
> -------
> 
> Currently, only KVM support root disk resize feature in ACS 4.4.1.
> As we are now using Xenserver 6.2.0, and it's so convient feature,
> So we do some hack.
> 
> 
> Diffs
> -----
> 
>   
> plugins/hypervisors/xen/src/com/cloud/hypervisor/xen/resource/XenServerStorageProcessor.java
>  e326770 
>   server/src/com/cloud/vm/UserVmManagerImpl.java 4fdacd5 
>   ui/scripts/instanceWizard.js 9df6ecc 
> 
> Diff: https://reviews.apache.org/r/29087/diff/
> 
> 
> Testing
> -------
> 
> Mgmt Server : CentOS release 6.4 (Final)
> ACS: 4.4.1
> Primary & Secondary : NFS
> 
> 
> Thanks,
> 
> Yitao Jiang
> 
>

Reply via email to