You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Chandan Purushothama (JIRA)" <ji...@apache.org> on 2013/07/30 00:23:49 UTC
[jira] [Closed] (CLOUDSTACK-1946) VMSnapshot Limitations Violation:
VM's memory snapshots are not automatically getting discarded if VM's
service offering is upgraded.
[ https://issues.apache.org/jira/browse/CLOUDSTACK-1946?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Chandan Purushothama closed CLOUDSTACK-1946.
--------------------------------------------
Verified on 4.2 Build.
> VMSnapshot Limitations Violation: VM's memory snapshots are not automatically getting discarded if VM's service offering is upgraded.
> -------------------------------------------------------------------------------------------------------------------------------------
>
> Key: CLOUDSTACK-1946
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-1946
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: Management Server
> Affects Versions: 4.2.0
> Reporter: Chandan Purushothama
> Assignee: Chandan Purushothama
> Fix For: 4.2.0
>
>
> ================
> Steps to Reproduce:
> ================
> 1. Create a "DiskAndMemorySnapshot" type VM snapshot for a VM - M1.
> 2. Create a "Disk" type VM snapshot for the same VM -D1.
> 3. Upgrade the Service offering for this VM.
> ===========
> Observations:
> ===========
> [root@asfmgmt ~]# grep -i "job-84" /var/log/cloudstack/management/management-server.log
> 2013-04-04 15:10:08,820 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-3:null) submit async job-84, details: AsyncJobVO {id:84, userId: 4, accountId: 4, sessionKey: null, instanceType: null, instanceId: 11, cmd: org.apache.cloudstack.api.command.user.vm.StartVMCmd, cmdOriginator: null, cmdInfo: {"response":"json","id":"fdcad7b3-f7c7-437f-af1d-6a5598996e50","sessionkey":"tS2YZXdWvuaD21qQKrpELMkXwvA\u003d","ctxUserId":"4","_":"1365113411836","ctxAccountId":"4","ctxStartEventId":"368"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 7200344900649, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-04-04 15:10:08,824 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-26:job-84) Executing org.apache.cloudstack.api.command.user.vm.StartVMCmd for job-84
> 2013-04-04 15:10:08,840 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-26:job-84) Access to VM[User|atoms-VM-1] granted to Acct[4-atoms] by DomainChecker_EnhancerByCloudStack_64286415
> 2013-04-04 15:10:08,851 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:08,854 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:08,862 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) DeploymentPlanner allocation algorithm: random
> 2013-04-04 15:10:08,862 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:1, requested cpu: 500, requested ram: 536870912
> 2013-04-04 15:10:08,862 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Is ROOT volume READY (pool already allocated)?: Yes
> 2013-04-04 15:10:08,862 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) This VM has last host_id specified, trying to choose the same host: 1
> 2013-04-04 15:10:08,866 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Checking if host: 1 has enough capacity for requested CPU: 500 and requested RAM: 536870912 , cpuOverprovisioningFactor: 1.0
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Hosts's actual total CPU: 4520 and CPU after applying overprovisioning: 4520
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) We need to allocate to the last host again, so checking if there is enough reserved capacity
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Reserved CPU: 500 , Requested CPU: 500
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Reserved RAM: 536870912 , Requested RAM: 536870912
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Host has enough CPU and RAM available
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) STATS: Can alloc CPU from host: 1, used: 2100, reserved: 500, actual total: 4520, total with overprovisioning: 4520; requested cpu:500,alloc_from_last_host?:true ,considerReservedCapacity?: true
> 2013-04-04 15:10:08,868 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) STATS: Can alloc MEM from host: 1, used: 1744830464, reserved: 536870912, total: 17169530880; requested mem: 536870912,alloc_from_last_host?:true ,considerReservedCapacity?: true
> 2013-04-04 15:10:08,868 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) The last host of this VM is UP and has enough capacity
> 2013-04-04 15:10:08,868 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Now checking for suitable pools under zone: 1, pod: 1, cluster: 1
> 2013-04-04 15:10:08,870 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Checking suitable pools for volume (Id, Type): (11,ROOT)
> 2013-04-04 15:10:08,870 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Volume has pool already allocated, checking if pool can be reused, poolId: 1
> 2013-04-04 15:10:08,871 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Planner need not allocate a pool for this volume since its READY
> 2013-04-04 15:10:08,871 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Trying to find a potenial host and associated storage pools from the suitable host/pool lists for this VM
> 2013-04-04 15:10:08,871 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Checking if host: 1 can access any suitable storage pool for volume: ROOT
> 2013-04-04 15:10:08,872 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Host: 1 can access pool: 1
> 2013-04-04 15:10:08,872 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Found a potential host id: 1 name: 10.223.58.2 and associated storage pools for this VM
> 2013-04-04 15:10:08,873 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) 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()]
> 2013-04-04 15:10:08,886 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: 1 new host id: null host id before state transition: null
> 2013-04-04 15:10:08,886 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Successfully transitioned to start state for VM[User|atoms-VM-1] reservation id = 27dd2766-1951-440c-98a4-65773b2c16d6
> 2013-04-04 15:10:08,891 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Trying to deploy VM, vm has dcId: 1 and podId: 1
> 2013-04-04 15:10:08,892 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) advanceStart: DeploymentPlan is provided, using dcId:1, podId: 1, clusterId: 1, hostId: 1, poolId: null
> 2013-04-04 15:10:08,892 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Deploy avoids pods: null, clusters: null, hosts: null
> 2013-04-04 15:10:08,894 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Root volume is ready, need to place VM in volume's cluster
> 2013-04-04 15:10:08,894 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) DeploymentPlanner allocation algorithm: random
> 2013-04-04 15:10:08,894 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:1, requested cpu: 500, requested ram: 536870912
> 2013-04-04 15:10:08,894 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Is ROOT volume READY (pool already allocated)?: Yes
> 2013-04-04 15:10:08,894 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) DeploymentPlan has host_id specified, making no checks on this host, looks like admin test: 1
> 2013-04-04 15:10:08,895 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Looking for suitable pools for this host under zone: 1, pod: 1, cluster: 1
> 2013-04-04 15:10:08,896 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Checking suitable pools for volume (Id, Type): (11,ROOT)
> 2013-04-04 15:10:08,897 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Volume has pool already allocated, checking if pool can be reused, poolId: 1
> 2013-04-04 15:10:08,898 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Planner need not allocate a pool for this volume since its READY
> 2013-04-04 15:10:08,898 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Trying to find a potenial host and associated storage pools from the suitable host/pool lists for this VM
> 2013-04-04 15:10:08,898 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Checking if host: 1 can access any suitable storage pool for volume: ROOT
> 2013-04-04 15:10:08,899 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Host: 1 can access pool: 1
> 2013-04-04 15:10:08,899 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) Found a potential host id: 1 name: 10.223.58.2 and associated storage pools for this VM
> 2013-04-04 15:10:08,900 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-26:job-84) 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()]
> 2013-04-04 15:10:08,900 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Deployment found - P0=VM[User|atoms-VM-1], 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()]
> 2013-04-04 15:10:08,909 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) VM state transitted from :Starting to Starting with event: OperationRetryvm's original host id: 1 new host id: 1 host id before state transition: null
> 2013-04-04 15:10:08,910 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) VM starting again on the last host it was stopped on
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Hosts's actual total CPU: 4520 and CPU after applying overprovisioning: 4520
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) We are allocating VM, increasing the used capacity of this host:1
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Current Used CPU: 2100 , Free CPU:1920 ,Requested CPU: 500
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Current Used RAM: 1744830464 , Free RAM:14887829504 ,Requested RAM: 536870912
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) We are allocating VM to the last host again, so adjusting the reserved capacity if it is not less than required
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Reserved CPU: 500 , Requested CPU: 500
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) Reserved RAM: 536870912 , Requested RAM: 536870912
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) CPU STATS after allocation: for host: 1, old used: 2100, old reserved: 500, actual total: 4520, total with overprovisioning: 4520; new used:2600, reserved:0; requested cpu:500,alloc_from_last:true
> 2013-04-04 15:10:08,916 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) RAM STATS after allocation: for host: 1, old used: 1744830464, old reserved: 536870912, total: 17169530880; new used: 2281701376, reserved: 0; requested mem: 536870912,alloc_from_last:true
> 2013-04-04 15:10:08,921 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) VM is being created in podId: 1
> 2013-04-04 15:10:08,923 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Lock is acquired for network id 205 as a part of network implement
> 2013-04-04 15:10:08,923 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Network id=205 is already implemented
> 2013-04-04 15:10:08,924 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Lock is released for network id 205 as a part of network implement
> 2013-04-04 15:10:08,935 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:08,939 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Changing active number of nics for network id=205 on 1
> 2013-04-04 15:10:08,943 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking JuniperSRX to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,946 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking Netscaler to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,949 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking F5BigIP to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,951 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking CiscoNexus1000vVSM to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,951 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking BigSwitchVnsElement to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,951 DEBUG [network.element.BigSwitchVnsElement] (Job-Executor-26:job-84) Checking if BigSwitchVnsElement can handle service Connectivity on network TestNetwork-atoms-1
> 2013-04-04 15:10:08,954 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking VirtualRouter to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:08,977 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-26:job-84) Lock is acquired for network id 205 as a part of router startup in 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()]
> 2013-04-04 15:10:08,980 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-26:job-84) Lock is released for network id 205 as a part of router startup in 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()]
> 2013-04-04 15:10:08,985 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:08,988 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-26:job-84) Applying dhcp entry in network Ntwk[205|Guest|8]
> 2013-04-04 15:10:09,001 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227770: Sending { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"routing.DhcpEntryCommand":{"vmMac":"02:00:6c:00:00:04","vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","defaultRouter":"10.1.1.1","defaultDns":"10.1.1.1","duid":"00:03:00:01:02:00:6c:00:00:04","isDefault":true,"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.name":"r-7-VMSNAP","router.ip":"10.223.58.4"},"wait":0}}] }
> 2013-04-04 15:10:09,001 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227770: Executing: { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"routing.DhcpEntryCommand":{"vmMac":"02:00:6c:00:00:04","vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","defaultRouter":"10.1.1.1","defaultDns":"10.1.1.1","duid":"00:03:00:01:02:00:6c:00:00:04","isDefault":true,"accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.name":"r-7-VMSNAP","router.ip":"10.223.58.4"},"wait":0}}] }
> 2013-04-04 15:10:12,495 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227770: Received: { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, { Answer } }
> 2013-04-04 15:10:12,504 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:12,507 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (Job-Executor-26:job-84) Applying userdata and password entry in network Ntwk[205|Guest|8]
> 2013-04-04 15:10:12,521 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227771: Sending { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"routing.SavePasswordCommand":{"password":"fnirq_cnffjbeq","vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"10.223.58.4","router.name":"r-7-VMSNAP"},"wait":0}},{"routing.VmDataCommand":{"vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"10.223.58.4","router.name":"r-7-VMSNAP"},"wait":0}}] }
> 2013-04-04 15:10:12,522 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227771: Executing: { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"routing.SavePasswordCommand":{"password":"fnirq_cnffjbeq","vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"10.223.58.4","router.name":"r-7-VMSNAP"},"wait":0}},{"routing.VmDataCommand":{"vmIpAddress":"10.1.1.149","vmName":"atoms-VM-1","accessDetails":{"router.guest.ip":"10.1.1.1","zone.network.type":"Advanced","router.ip":"10.223.58.4","router.name":"r-7-VMSNAP"},"wait":0}}] }
> 2013-04-04 15:10:16,772 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227771: Received: { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, { Answer, Answer } }
> 2013-04-04 15:10:16,772 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking Ovs to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:16,772 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking SecurityGroupProvider to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:16,775 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-26:job-84) Asking VpcVirtualRouter to prepare for Nic[22-11-27dd2766-1951-440c-98a4-65773b2c16d6-10.1.1.149]
> 2013-04-04 15:10:16,778 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:16,779 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-26:job-84) Checking if we need to prepare 1 volumes for VM[User|atoms-VM-1]
> 2013-04-04 15:10:16,779 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-26:job-84) No need to recreate the volume: Vol[11|vm=11|ROOT], since it already has a pool assigned: 1, adding disk to VM
> 2013-04-04 15:10:16,793 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227772: Sending { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"StartCommand":{"vm":{"id":11,"name":"i-4-11-VMSNAP","bootloader":"HVM","type":"User","cpus":1,"minSpeed":500,"maxSpeed":500,"minRam":536870912,"maxRam":536870912,"arch":"x86_64","os":"CentOS 5.3 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"vncPassword":"cebf388dfffe758","params":{"rootDiskController":"ide","nicAdapter":"E1000"},"uuid":"fdcad7b3-f7c7-437f-af1d-6a5598996e50","disks":[{"id":11,"name":"ROOT-11","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-11-11-000004","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":11,"name":"CentOS 5.3(64-bit) no GUI (vSphere)","size":0,"type":"ISO","storagePoolType":"ISO","deviceId":3}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"5f4fd59f-df59-41bb-bfd9-de15c8a89e6a","ip":"10.1.1.149","netmask":"255.255.255.0","gateway":"10.1.1.1","mac":"02:00:6c:00:00:04","dns1":"8.8.8.8","dns2":"8.8.4.4","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2241","isolationUri":"vlan://2241","isSecurityGroupEnabled":false}]},"hostIp":"10.223.58.2","wait":0}}] }
> 2013-04-04 15:10:16,794 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227772: Executing: { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"StartCommand":{"vm":{"id":11,"name":"i-4-11-VMSNAP","bootloader":"HVM","type":"User","cpus":1,"minSpeed":500,"maxSpeed":500,"minRam":536870912,"maxRam":536870912,"arch":"x86_64","os":"CentOS 5.3 (64-bit)","bootArgs":"","rebootOnCrash":false,"enableHA":false,"limitCpuUse":false,"vncPassword":"cebf388dfffe758","params":{"rootDiskController":"ide","nicAdapter":"E1000"},"uuid":"fdcad7b3-f7c7-437f-af1d-6a5598996e50","disks":[{"id":11,"name":"ROOT-11","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-11-11-000004","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":11,"name":"CentOS 5.3(64-bit) no GUI (vSphere)","size":0,"type":"ISO","storagePoolType":"ISO","deviceId":3}],"nics":[{"deviceId":0,"networkRateMbps":200,"defaultNic":true,"uuid":"5f4fd59f-df59-41bb-bfd9-de15c8a89e6a","ip":"10.1.1.149","netmask":"255.255.255.0","gateway":"10.1.1.1","mac":"02:00:6c:00:00:04","dns1":"8.8.8.8","dns2":"8.8.4.4","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2241","isolationUri":"vlan://2241","isSecurityGroupEnabled":false}]},"hostIp":"10.223.58.2","wait":0}}] }
> 2013-04-04 15:10:26,218 DEBUG [agent.transport.Request] (Job-Executor-26:job-84) Seq 1-1397227772: Received: { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, { StartAnswer } }
> 2013-04-04 15:10:26,259 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:26,262 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-26:job-84) Service SecurityGroup is not supported in the network id=205
> 2013-04-04 15:10:26,267 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-26:job-84) VM state transitted from :Starting to Running with event: OperationSucceededvm's original host id: 1 new host id: 1 host id before state transition: 1
> 2013-04-04 15:10:26,267 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-26:job-84) Start completed for VM VM[User|atoms-VM-1]
> 2013-04-04 15:10:26,277 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-26:job-84) Complete async job-84, jobStatus: 1, resultCode: 0, result: org.apache.cloudstack.api.response.UserVmResponse@619936d
> 2013-04-04 15:10:26,371 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-26:job-84) Done executing org.apache.cloudstack.api.command.user.vm.StartVMCmd for job-84
> 2013-04-04 15:10:26,809 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-14:null) Async job-84 completed
> [root@asfmgmt ~]#
> mysql> select id,name,display_name,vm_id,account_id,vm_snapshot_type,state,parent,current,update_count,updated,created,removed from vm_snapshots where vm_id=11;
> +----+---------------------------------+-----------------------+-------+------------+------------------+-------+--------+---------+--------------+---------------------+---------------------+---------+
> | id | name | display_name | vm_id | account_id | vm_snapshot_type | state | parent | current | update_count | updated | created | removed |
> +----+---------------------------------+-----------------------+-------+------------+------------------+-------+--------+---------+--------------+---------------------+---------------------+---------+
> | 1 | i-4-11-VMSNAP_VS_20130402235913 | vmsnap-atm-vm-1-1 | 11 | 4 | Disk | Ready | NULL | 0 | 4 | 2013-04-03 00:02:55 | 2013-04-02 23:59:13 | NULL |
> | 4 | i-4-11-VMSNAP_VS_20130403205843 | vmsnap-run-atm-vm-1-2 | 11 | 4 | Disk | Ready | 1 | 1 | 6 | 2013-04-03 23:17:41 | 2013-04-03 20:58:43 | NULL |
> | 5 | i-4-11-VMSNAP_VS_20130403210837 | vmsnap-run-atm-vm-1-3 | 11 | 4 | DiskAndMemory | Ready | 4 | 0 | 6 | 2013-04-03 22:28:43 | 2013-04-03 21:08:37 | NULL |
> +----+---------------------------------+-----------------------+-------+------------+------------------+-------+--------+---------+--------------+---------------------+---------------------+---------+
> 3 rows in set (0.00 sec)
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira