cloudstack-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Chandan Purushothama (JIRA)" <j...@apache.org>
Subject [jira] [Created] (CLOUDSTACK-1944) VMSnapshot: Destruction of a VM with VMSnapshots throws a NullPointerException during VM Expunge
Date Thu, 04 Apr 2013 21:46:15 GMT
Chandan Purushothama created CLOUDSTACK-1944:
------------------------------------------------

             Summary: VMSnapshot: Destruction of a VM with VMSnapshots throws a NullPointerException
during VM Expunge
                 Key: CLOUDSTACK-1944
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-1944
             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
             Fix For: 4.2.0



================
Steps to Reproduce:
================

1. Create multiple VM snapshots for the same VM - say 3 snapshots - S1,S2,S3.
2. Destroy the VM.

===========
Observations:
===========
*Management Server Log*

[root@asfmgmt ~]# zgrep -i "job-81" /var/log/cloudstack/management/management-server.log.2013-04-03.gz
2013-04-03 17:54:07,786 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-9:null) submit
async job-81, details: AsyncJobVO {id:81, userId: 4, accountId: 4, sessionKey: null, instanceType:
null, instanceId: 12, cmd: org.apache.cloudstack.api.command.user.vm.DestroyVMCmd, cmdOriginator:
null, cmdInfo: {"id":"913e49e6-308b-4d5c-8d05-20942926ef4c","response":"json","sessionkey":"9gP56fKnip2ipT8G+MLx1V14H3M\u003d","ctxUserId":"4","_":"1365036849438","ctxAccountId":"4","ctxStartEventId":"334"},
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-03 17:54:07,790 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-23:job-81) Executing
org.apache.cloudstack.api.command.user.vm.DestroyVMCmd for job-81
2013-04-03 17:54:07,806 DEBUG [cloud.user.AccountManagerImpl] (Job-Executor-23:job-81) Access
to VM[User|atoms-VM-2] granted to Acct[4-atoms] by DomainChecker_EnhancerByCloudStack_64286415
2013-04-03 17:54:07,813 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-23:job-81)
Destroying vm VM[User|atoms-VM-2]
2013-04-03 17:54:07,819 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
VM state transitted from :Running to Stopping with event: StopRequestedvm's original host
id: 1 new host id: 1 host id before state transition: 1
2013-04-03 17:54:07,820 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534049:
Sending  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"i-4-12-VMSNAP","wait":0}}]
}
2013-04-03 17:54:07,821 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534049:
Executing:  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"i-4-12-VMSNAP","wait":0}}]
}
2013-04-03 17:54:13,005 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534049:
Received:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, { StopAnswer } }
2013-04-03 17:54:13,007 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-23:job-81)
VM[User|atoms-VM-2] is stopped on the host.  Proceeding to release resource held.
2013-04-03 17:54:13,011 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-23:job-81) Service
SecurityGroup is not supported in the network id=205
2013-04-03 17:54:13,014 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Changing active number of nics for network id=205 on -1
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking JuniperSRX to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking Netscaler to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking F5BigIP to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking CiscoNexus1000vVSM to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking BigSwitchVnsElement to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [network.element.BigSwitchVnsElement] (Job-Executor-23:job-81)
Checking if BigSwitchVnsElement can handle service Connectivity on network TestNetwork-atoms-1
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking VirtualRouter to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking Ovs to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking SecurityGroupProvider to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-23:job-81)
Asking VpcVirtualRouter to release Nic[23-12-9816ddea-0ec7-42a1-b772-9b61c2721e77-10.1.1.217]
2013-04-03 17:54:13,018 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-23:job-81)
Successfully released network resources for the vm VM[User|atoms-VM-2]
2013-04-03 17:54:13,018 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-23:job-81)
Successfully released storage resources for the vm VM[User|atoms-VM-2]
2013-04-03 17:54:13,031 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-23:job-81) Service
SecurityGroup is not supported in the network id=205
2013-04-03 17:54:13,035 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-23:job-81) Service
SecurityGroup is not supported in the network id=205
2013-04-03 17:54:13,046 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
VM state transitted from :Stopping to Stopped with event: OperationSucceededvm's original
host id: 1 new host id: null host id before state transition: 1
2013-04-03 17:54:13,051 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
Hosts's actual total CPU: 4520 and CPU after applying overprovisioning: 4520
2013-04-03 17:54:13,051 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
Hosts's actual total RAM: 17169530880 and RAM after applying overprovisioning: 17169530880
2013-04-03 17:54:13,051 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
release cpu from host: 1, old used: 1800,reserved: 0, actual total: 4520, total with overprovisioning:
4520; new used: 1700,reserved:100; movedfromreserved: false,moveToReserveredtrue
2013-04-03 17:54:13,051 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
release mem from host: 1, old used: 1879048192,reserved: 0, total: 17169530880; new used:
1744830464,reserved:134217728; movedfromreserved: false,moveToReserveredtrue
2013-04-03 17:54:13,072 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534050:
Sending  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":2,"snapshotName":"i-4-12-VMSNAP_VS_20130403011101","type":"Disk","createTime":1364951461000,"current":false,"description":"vmsnap-atm-vm-2-1"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:54:13,072 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534050:
Executing:  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":2,"snapshotName":"i-4-12-VMSNAP_VS_20130403011101","type":"Disk","createTime":1364951461000,"current":false,"description":"vmsnap-atm-vm-2-1"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:54:44,101 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534050:
Received:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 10, { DeleteVMSnapshotAnswer
} }
2013-04-03 17:54:44,109 DEBUG [vm.snapshot.VMSnapshotManagerImpl] (Job-Executor-23:job-81)
Delete VM snapshot i-4-12-VMSNAP_VS_20130403011101 succeeded for vm: i-4-12-VMSNAP
2013-04-03 17:54:44,124 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534052:
Sending  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":6,"snapshotName":"i-4-12-VMSNAP_VS_20130403212447","type":"DiskAndMemory","createTime":1365024287000,"current":false,"description":"vmsnap-run-atm-vm-2-2"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:54:44,125 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534052:
Executing:  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":6,"snapshotName":"i-4-12-VMSNAP_VS_20130403212447","type":"DiskAndMemory","createTime":1365024287000,"current":false,"description":"vmsnap-run-atm-vm-2-2"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:54:47,217 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534052:
Received:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 10, { DeleteVMSnapshotAnswer
} }
2013-04-03 17:54:47,225 DEBUG [vm.snapshot.VMSnapshotManagerImpl] (Job-Executor-23:job-81)
Delete VM snapshot i-4-12-VMSNAP_VS_20130403212447 succeeded for vm: i-4-12-VMSNAP
2013-04-03 17:54:47,255 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534053:
Sending  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":8,"snapshotName":"i-4-12-VMSNAP_VS_20130403232140","type":"Disk","createTime":1365031300000,"current":true,"description":"vmsnap-run-atm-vm-2-3"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:54:47,255 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534053:
Executing:  { Cmd , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 100011, [{"DeleteVMSnapshotCommand":{"volumeTOs":[{"id":12,"name":"ROOT-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"ROOT-12-12-000003","size":2147483648,"type":"ROOT","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":0},{"id":13,"name":"DATA-12","mountPoint":"/export/home/chandan/asf4-131-170/primary","path":"cee5b5a1f7844506825ce0075f17eb46-000003","size":5368709120,"type":"DATADISK","storagePoolType":"NetworkFilesystem","storagePoolUuid":"f42a60c2-0940-305b-bb14-23d8b40f42bc","deviceId":1}],"target":{"id":8,"snapshotName":"i-4-12-VMSNAP_VS_20130403232140","type":"Disk","createTime":1365031300000,"current":true,"description":"vmsnap-run-atm-vm-2-3"},"vmName":"i-4-12-VMSNAP","guestOSType":"CentOS
5.3 (64-bit)","wait":0}}] }
2013-04-03 17:57:48,342 DEBUG [agent.transport.Request] (Job-Executor-23:job-81) Seq 1-695534053:
Received:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 10, { DeleteVMSnapshotAnswer
} }
2013-04-03 17:57:48,350 DEBUG [vm.snapshot.VMSnapshotManagerImpl] (Job-Executor-23:job-81)
Delete VM snapshot i-4-12-VMSNAP_VS_20130403232140 succeeded for vm: i-4-12-VMSNAP
2013-04-03 17:57:48,360 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
VM state transitted from :Stopped to Destroyed with event: DestroyRequestedvm's original host
id: 1 new host id: null host id before state transition: null
2013-04-03 17:57:48,366 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
Hosts's actual total CPU: 4520 and CPU after applying overprovisioning: 4520
2013-04-03 17:57:48,366 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
Hosts's actual total RAM: 17169530880 and RAM after applying overprovisioning: 17169530880
2013-04-03 17:57:48,366 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
release cpu from host: 1, old used: 1700,reserved: 100, actual total: 4520, total with overprovisioning:
4520; new used: 1700,reserved:0; movedfromreserved: true,moveToReserveredfalse
2013-04-03 17:57:48,366 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-23:job-81)
release mem from host: 1, old used: 1744830464,reserved: 134217728, total: 17169530880; new
used: 1744830464,reserved:0; movedfromreserved: true,moveToReserveredfalse
2013-04-03 17:57:48,439 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-23:job-81) Complete
async job-81, jobStatus: 1, resultCode: 0, result: org.apache.cloudstack.api.response.UserVmResponse@5417c02e
2013-04-03 17:57:48,445 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-23:job-81) Done
executing org.apache.cloudstack.api.command.user.vm.DestroyVMCmd for job-81
2013-04-03 17:57:49,883 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-23:null) Async
job-81 completed
[root@asfmgmt ~]#

.
.
.
.
.
.
.

2013-04-03 17:59:10,452 INFO  [vmware.resource.VmwareResource] (DirectAgent-288:10.223.58.2)
Destroy root volume directly from datastore
2013-04-03 17:59:10,452 INFO  [vmware.resource.VmwareResource] (DirectAgent-288:10.223.58.2)
Destroy volume by original name: ROOT-12-12.vmdk
2013-04-03 17:59:10,473 INFO  [vmware.mo.DatastoreMO] (DirectAgent-288:10.223.58.2) Search
file ROOT-12-12.vmdk on [f42a60c20940305bbb1423d8b40f42bc]
2013-04-03 17:59:10,543 INFO  [vmware.mo.DatastoreMO] (DirectAgent-288:10.223.58.2) File [f42a60c20940305bbb1423d8b40f42bc]
ROOT-12-12.vmdk exists on datastore
2013-04-03 17:59:10,648 INFO  [vmware.resource.VmwareResource] (DirectAgent-288:10.223.58.2)
Destroy volume by derived name: ROOT-12-12-flat.vmdk
2013-04-03 17:59:10,658 INFO  [vmware.mo.DatastoreMO] (DirectAgent-288:10.223.58.2) Search
file ROOT-12-12-flat.vmdk on [f42a60c20940305bbb1423d8b40f42bc]
2013-04-03 17:59:10,716 INFO  [vmware.mo.DatastoreMO] (DirectAgent-288:10.223.58.2) File [f42a60c20940305bbb1423d8b40f42bc]
ROOT-12-12-flat.vmdk exists on datastore
2013-04-03 17:59:15,042 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-4:null)
Ping from 3
2013-04-03 17:59:15,371 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-5:null)
Ping from 4
2013-04-03 17:59:16,861 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-288:null) Seq
1-695534065: Response Received:
2013-04-03 17:59:16,861 DEBUG [agent.transport.Request] (DirectAgent-288:null) Seq 1-695534065:
Processing:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, [{"Answer":{"result":true,"details":"Success","wait":0}}]
}
2013-04-03 17:59:16,861 DEBUG [agent.transport.Request] (UserVm-Scavenger-1:null) Seq 1-695534065:
Received:  { Ans: , MgmtId: 7200344900649, via: 1, Ver: v1, Flags: 110, { Answer } }
2013-04-03 17:59:16,863 DEBUG [agent.manager.AgentAttache] (DirectAgent-288:null) Seq 1-695534065:
No more commands found
2013-04-03 17:59:16,872 DEBUG [cloud.vm.VirtualMachineManagerImpl] (UserVm-Scavenger-1:null)
Expunged VM[User|atoms-VM-2]
2013-04-03 17:59:16,872 DEBUG [cloud.vm.UserVmManagerImpl] (UserVm-Scavenger-1:null) Starting
cleaning up vm VM[User|atoms-VM-2] resources...
2013-04-03 17:59:16,912 DEBUG [network.firewall.FirewallManagerImpl] (UserVm-Scavenger-1:null)
No firewall rules are found for vm id=12
2013-04-03 17:59:16,912 DEBUG [cloud.vm.UserVmManagerImpl] (UserVm-Scavenger-1:null) Firewall
rules are removed successfully as a part of vm id=12 expunge
2013-04-03 17:59:16,914 DEBUG [network.rules.RulesManagerImpl] (UserVm-Scavenger-1:null) No
port forwarding rules are found for vm id=12
2013-04-03 17:59:16,914 DEBUG [cloud.vm.UserVmManagerImpl] (UserVm-Scavenger-1:null) Port
forwarding rules are removed successfully as a part of vm id=12 expunge
2013-04-03 17:59:16,921 DEBUG [cloud.vm.UserVmManagerImpl] (UserVm-Scavenger-1:null) Removed
vm id=12 from all load balancers as a part of expunge process
2013-04-03 17:59:16,924 DEBUG [network.rules.RulesManagerImpl] (UserVm-Scavenger-1:null) Revoking
all Firewallrules as a part of disabling static nat for public IP id=9
2013-04-03 17:59:16,926 DEBUG [network.firewall.FirewallManagerImpl] (UserVm-Scavenger-1:null)
Releasing 1 firewall rules for ip id=9
2013-04-03 17:59:16,927 WARN  [cloud.vm.UserVmManagerImpl] (UserVm-Scavenger-1:null) Unable
to expunge VM[User|atoms-VM-2]
java.lang.NullPointerException
        at com.cloud.event.EventUtils.getDomainId(EventUtils.java:116)
        at com.cloud.event.EventUtils.saveStartedEvent(EventUtils.java:79)
        at com.cloud.event.ActionEventInterceptor.interceptStart(ActionEventInterceptor.java:47)
        at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:119)
        at com.cloud.network.firewall.FirewallManagerImpl.revokeFirewallRulesForIp(FirewallManagerImpl.java:734)
        at com.cloud.network.rules.RulesManagerImpl.disableStaticNat(RulesManagerImpl.java:1242)
        at com.cloud.vm.UserVmManagerImpl.cleanupVmResources(UserVmManagerImpl.java:1442)
        at com.cloud.vm.UserVmManagerImpl.expunge(UserVmManagerImpl.java:1373)
        at com.cloud.vm.UserVmManagerImpl$ExpungeTask.run(UserVmManagerImpl.java:1530)
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
        at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
        at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165)
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267)
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
        at java.lang.Thread.run(Thread.java:679)
2013-04-03 17:59:25,827 DEBUG [cloud.server.StatsCollector] (StatsCollector-3:null) VmStatsCollector
is running...
2013-04-03 17:59:25,837 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-289:null) Seq
1-695534066: Executing request


--
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

Mime
View raw message