[
https://issues.apache.org/jira/browse/CLOUDSTACK-2793?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
angeline shen updated CLOUDSTACK-2793:
--------------------------------------
Description:
1. advance zone. Add 2 hosts.
create PVLAN shared network with VLAN ID, private VLAN ID, IPV4 gateway,
netmask, start IP, end IP
gateway primary vlan secondary vlan IP
network1: 10.223.161.65 1611 998
10.223.161.110- 10.223.161.113
network2: 10.223.161.129 1612 997
10.223.161.150-10.223.161.153
2. Deploy VMs in both PVLAN shared network
3. stop VMs in both PVLAN shared networks
4. Start stopped VMs in network2 failed . Start stopped VMs in network1
succeeded.
2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-57:job-55) Successfully released network resources for the vm
VM[User|z1admin1612-153V86]
2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-57:job-55) Successfully cleanued up resources for the vm
VM[User|z1admin1612-153V86] in Starting state
2013-05-31 20:01:36,077 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) VM state transitted from :Starting to Stopped with
event: OperationFailedvm's original host id: 4 new host id: null host id before
s
tate transition: 4
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) Hosts's actual total CPU: 9040 and CPU after applying
overprovisioning: 9040
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) Hosts's actual total RAM: 16816881664 and RAM after
applying overprovisioning: 16816881664
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) release cpu from host: 4, old used: 1200,reserved: 0,
actual total: 9040, total with overprovisioning: 9040; new used: 1100,reserved
:0; movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) release mem from host: 4, old used:
2281701376,reserved: 0, total: 16816881664; new used: 1744830464,reserved:0;
movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:01:36,101 ERROR [cloud.async.AsyncJobManagerImpl]
(Job-Executor-57:job-55) Unexpected exception while executing
org.apache.cloudstack.api.command.user.vm.StartVMCmd
com.cloud.exception.AgentUnavailableException: Resource [Host:4] is
unreachable: Host 4: Unable to start instance due to Unable to get answer that
is of class com.cloud.agent.api.StartAnswer
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
at
org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
at
com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
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)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
answer that is of class com.cloud.agent.api.StartAnswer
at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
... 19 more
2013-05-31 20:01:36,102 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-57:job-55) Complete async job-55, jobStatus: 2, resultCode: 530,
result: Error Code: 530 Error text: Resource [Host:4] is unreachable: Host 4:
Unable to start instance due to Unable to get answer that is of class
com.cloud.agent.api.StartAnswer
2013-05-31 20:01:36,735 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) HostStatsCollector is running...
2013-05-31 20:01:36,953 DEBUG [agent.transport.Request]
(AgentManager-Handler-10:null) Seq 3-832705172: Processing: { Ans: , MgmtId:
6655051826959, via: 3, Ver: v1, Flags: 10,
[{"Answer":{"result":false,"details":"empty String","wait":0}}] }
2013-05-31 20:01:36,953 DEBUG [agent.transport.Request] (StatsCollector-3:null)
Seq 3-832705172: Received: { Ans: , MgmtId: 6655051826959, via: 3, Ver: v1,
Flags: 10, { Answer } }
.............
2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-56:job-54) Successfully released network resources for the vm
VM[User|z1admin1612-153V91]
2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-56:job-54) Successfully cleanued up resources for the vm
VM[User|z1admin1612-153V91] in Starting state
2013-05-31 20:00:51,998 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
===START=== 10.216.133.70 -- GET
command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%
2B3O%2F1spFKU5g%3D&_=1370055896240
2013-05-31 20:00:52,935 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) VM state transitted from :Starting to Stopped with
event: OperationFailedvm's original host id: 3 new host id: null host id before
s
tate transition: 3
2013-05-31 20:00:52,943 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
===END=== 10.216.133.70 -- GET
command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%2B
3O%2F1spFKU5g%3D&_=1370055896240
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) Hosts's actual total CPU: 9044 and CPU after applying
overprovisioning: 9044
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) Hosts's actual total RAM: 4066250752 and RAM after
applying overprovisioning: 4066250752
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) release cpu from host: 3, old used: 1200,reserved: 0,
actual total: 9044, total with overprovisioning: 9044; new used: 1100,reserved
:0; movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) release mem from host: 3, old used:
1476395008,reserved: 0, total: 4066250752; new used: 939524096,reserved:0;
movedfromreserved: fa
lse,moveToReserveredfalse
2013-05-31 20:00:52,959 ERROR [cloud.async.AsyncJobManagerImpl]
(Job-Executor-56:job-54) Unexpected exception while executing
org.apache.cloudstack.api.command.user.vm.StartVMCmd
com.cloud.exception.AgentUnavailableException: Resource [Host:3] is
unreachable: Host 3: Unable to start instance due to Unable to get answer that
is of class com.cloud.agent.api.StartAnswer
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
at
org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
at
com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
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)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
answer that is of class com.cloud.agent.api.StartAnswer
at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
... 19 more
2013-05-31 20:00:52,960 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-56:job-54) Complete async job-54, jobStatus: 2, resultCode: 530,
result: Error Code: 530 Error text: Resource [Host:3] is unreachable: Host 3:
Una
ble to start instance due to Unable to get answer that is of class
com.cloud.agent.api.StartAnswer
2013-05-31 20:00:53,554 DEBUG [storage.secondary.SecondaryStorageManagerImpl]
(secstorage-1:null) Zone 1 is ready to launch secondary storage VM
was:
1. advance zone. Add 2 hosts.
create PVLAN shared network with VLAN ID, private VLAN ID, IPV4 gateway,
netmask, start IP, end IP
2. Deploy VMs in PVLAN shared network
3. stop VM
4. Start stopped VM failed
2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-57:job-55) Successfully released network resources for the vm
VM[User|z1admin1612-153V86]
2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-57:job-55) Successfully cleanued up resources for the vm
VM[User|z1admin1612-153V86] in Starting state
2013-05-31 20:01:36,077 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) VM state transitted from :Starting to Stopped with
event: OperationFailedvm's original host id: 4 new host id: null host id before
s
tate transition: 4
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) Hosts's actual total CPU: 9040 and CPU after applying
overprovisioning: 9040
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) Hosts's actual total RAM: 16816881664 and RAM after
applying overprovisioning: 16816881664
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) release cpu from host: 4, old used: 1200,reserved: 0,
actual total: 9040, total with overprovisioning: 9040; new used: 1100,reserved
:0; movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-57:job-55) release mem from host: 4, old used:
2281701376,reserved: 0, total: 16816881664; new used: 1744830464,reserved:0;
movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:01:36,101 ERROR [cloud.async.AsyncJobManagerImpl]
(Job-Executor-57:job-55) Unexpected exception while executing
org.apache.cloudstack.api.command.user.vm.StartVMCmd
com.cloud.exception.AgentUnavailableException: Resource [Host:4] is
unreachable: Host 4: Unable to start instance due to Unable to get answer that
is of class com.cloud.agent.api.StartAnswer
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
at
org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
at
com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
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)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
answer that is of class com.cloud.agent.api.StartAnswer
at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
... 19 more
2013-05-31 20:01:36,102 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-57:job-55) Complete async job-55, jobStatus: 2, resultCode: 530,
result: Error Code: 530 Error text: Resource [Host:4] is unreachable: Host 4:
Unable to start instance due to Unable to get answer that is of class
com.cloud.agent.api.StartAnswer
2013-05-31 20:01:36,735 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) HostStatsCollector is running...
2013-05-31 20:01:36,953 DEBUG [agent.transport.Request]
(AgentManager-Handler-10:null) Seq 3-832705172: Processing: { Ans: , MgmtId:
6655051826959, via: 3, Ver: v1, Flags: 10,
[{"Answer":{"result":false,"details":"empty String","wait":0}}] }
2013-05-31 20:01:36,953 DEBUG [agent.transport.Request] (StatsCollector-3:null)
Seq 3-832705172: Received: { Ans: , MgmtId: 6655051826959, via: 3, Ver: v1,
Flags: 10, { Answer } }
.............
2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-56:job-54) Successfully released network resources for the vm
VM[User|z1admin1612-153V91]
2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(Job-Executor-56:job-54) Successfully cleanued up resources for the vm
VM[User|z1admin1612-153V91] in Starting state
2013-05-31 20:00:51,998 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
===START=== 10.216.133.70 -- GET
command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%
2B3O%2F1spFKU5g%3D&_=1370055896240
2013-05-31 20:00:52,935 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) VM state transitted from :Starting to Stopped with
event: OperationFailedvm's original host id: 3 new host id: null host id before
s
tate transition: 3
2013-05-31 20:00:52,943 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
===END=== 10.216.133.70 -- GET
command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%2B
3O%2F1spFKU5g%3D&_=1370055896240
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) Hosts's actual total CPU: 9044 and CPU after applying
overprovisioning: 9044
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) Hosts's actual total RAM: 4066250752 and RAM after
applying overprovisioning: 4066250752
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) release cpu from host: 3, old used: 1200,reserved: 0,
actual total: 9044, total with overprovisioning: 9044; new used: 1100,reserved
:0; movedfromreserved: false,moveToReserveredfalse
2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
(Job-Executor-56:job-54) release mem from host: 3, old used:
1476395008,reserved: 0, total: 4066250752; new used: 939524096,reserved:0;
movedfromreserved: fa
lse,moveToReserveredfalse
2013-05-31 20:00:52,959 ERROR [cloud.async.AsyncJobManagerImpl]
(Job-Executor-56:job-54) Unexpected exception while executing
org.apache.cloudstack.api.command.user.vm.StartVMCmd
com.cloud.exception.AgentUnavailableException: Resource [Host:3] is
unreachable: Host 3: Unable to start instance due to Unable to get answer that
is of class com.cloud.agent.api.StartAnswer
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
at
org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
at
com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
at java.util.concurrent.FutureTask.run(FutureTask.java:166)
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)
Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
answer that is of class com.cloud.agent.api.StartAnswer
at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
... 19 more
2013-05-31 20:00:52,960 DEBUG [cloud.async.AsyncJobManagerImpl]
(Job-Executor-56:job-54) Complete async job-54, jobStatus: 2, resultCode: 530,
result: Error Code: 530 Error text: Resource [Host:3] is unreachable: Host 3:
Una
ble to start instance due to Unable to get answer that is of class
com.cloud.agent.api.StartAnswer
2013-05-31 20:00:53,554 DEBUG [storage.secondary.SecondaryStorageManagerImpl]
(secstorage-1:null) Zone 1 is ready to launch secondary storage VM
> PVLAN - Ubuntu 13.04 - Unable to start Stopped VM
> -------------------------------------------------
>
> Key: CLOUDSTACK-2793
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2793
> 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
> Environment: MS ubuntu 13.04 KVM ACS 4.2 PVLAN
> host ubuntu 13.04 KVM ACS 4.2 PVLAN
> Reporter: angeline shen
> Assignee: Sheng Yang
> Priority: Critical
> Fix For: 4.2.0
>
> Attachments: management-server.log.gz, Screenshot-CloudStack -
> Mozilla Firefox-5.png
>
>
> 1. advance zone. Add 2 hosts.
> create PVLAN shared network with VLAN ID, private VLAN ID, IPV4 gateway,
> netmask, start IP, end IP
> gateway primary vlan secondary vlan IP
> network1: 10.223.161.65 1611 998
> 10.223.161.110- 10.223.161.113
> network2: 10.223.161.129 1612 997
> 10.223.161.150-10.223.161.153
> 2. Deploy VMs in both PVLAN shared network
> 3. stop VMs in both PVLAN shared networks
> 4. Start stopped VMs in network2 failed . Start stopped VMs in network1
> succeeded.
> 2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-57:job-55) Successfully released network resources for the vm
> VM[User|z1admin1612-153V86]
> 2013-05-31 20:01:36,070 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-57:job-55) Successfully cleanued up resources for the vm
> VM[User|z1admin1612-153V86] in Starting state
> 2013-05-31 20:01:36,077 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-57:job-55) VM state transitted from :Starting to Stopped with
> event: OperationFailedvm's original host id: 4 new host id: null host id
> before s
> tate transition: 4
> 2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-57:job-55) Hosts's actual total CPU: 9040 and CPU after
> applying overprovisioning: 9040
> 2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-57:job-55) Hosts's actual total RAM: 16816881664 and RAM after
> applying overprovisioning: 16816881664
> 2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-57:job-55) release cpu from host: 4, old used: 1200,reserved:
> 0, actual total: 9040, total with overprovisioning: 9040; new used:
> 1100,reserved
> :0; movedfromreserved: false,moveToReserveredfalse
> 2013-05-31 20:01:36,084 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-57:job-55) release mem from host: 4, old used:
> 2281701376,reserved: 0, total: 16816881664; new used: 1744830464,reserved:0;
> movedfromreserved: false,moveToReserveredfalse
> 2013-05-31 20:01:36,101 ERROR [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-57:job-55) Unexpected exception while executing
> org.apache.cloudstack.api.command.user.vm.StartVMCmd
> com.cloud.exception.AgentUnavailableException: Resource [Host:4] is
> unreachable: Host 4: Unable to start instance due to Unable to get answer
> that is of class com.cloud.agent.api.StartAnswer
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
> at
> org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
> at
> org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
> at
> com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
> at
> com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
> at
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> 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)
> Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
> answer that is of class com.cloud.agent.api.StartAnswer
> at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
> ... 19 more
> 2013-05-31 20:01:36,102 DEBUG [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-57:job-55) Complete async job-55, jobStatus: 2, resultCode:
> 530, result: Error Code: 530 Error text: Resource [Host:4] is unreachable:
> Host 4: Unable to start instance due to Unable to get answer that is of class
> com.cloud.agent.api.StartAnswer
> 2013-05-31 20:01:36,735 DEBUG [cloud.server.StatsCollector]
> (StatsCollector-3:null) HostStatsCollector is running...
> 2013-05-31 20:01:36,953 DEBUG [agent.transport.Request]
> (AgentManager-Handler-10:null) Seq 3-832705172: Processing: { Ans: , MgmtId:
> 6655051826959, via: 3, Ver: v1, Flags: 10,
> [{"Answer":{"result":false,"details":"empty String","wait":0}}] }
> 2013-05-31 20:01:36,953 DEBUG [agent.transport.Request]
> (StatsCollector-3:null) Seq 3-832705172: Received: { Ans: , MgmtId:
> 6655051826959, via: 3, Ver: v1, Flags: 10, { Answer } }
> .............
> 2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-56:job-54) Successfully released network resources for the vm
> VM[User|z1admin1612-153V91]
> 2013-05-31 20:00:51,587 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (Job-Executor-56:job-54) Successfully cleanued up resources for the vm
> VM[User|z1admin1612-153V91] in Starting state
> 2013-05-31 20:00:51,998 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
> ===START=== 10.216.133.70 -- GET
> command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%
> 2B3O%2F1spFKU5g%3D&_=1370055896240
> 2013-05-31 20:00:52,935 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-56:job-54) VM state transitted from :Starting to Stopped with
> event: OperationFailedvm's original host id: 3 new host id: null host id
> before s
> tate transition: 3
> 2013-05-31 20:00:52,943 DEBUG [cloud.api.ApiServlet] (catalina-exec-15:null)
> ===END=== 10.216.133.70 -- GET
> command=queryAsyncJobResult&jobId=c17ba6ba-5f84-4514-8d1c-0f0a9f6c840a&response=json&sessionkey=dt1MF5Ukqwpq4Hb%2B
> 3O%2F1spFKU5g%3D&_=1370055896240
> 2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-56:job-54) Hosts's actual total CPU: 9044 and CPU after
> applying overprovisioning: 9044
> 2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-56:job-54) Hosts's actual total RAM: 4066250752 and RAM after
> applying overprovisioning: 4066250752
> 2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-56:job-54) release cpu from host: 3, old used: 1200,reserved:
> 0, actual total: 9044, total with overprovisioning: 9044; new used:
> 1100,reserved
> :0; movedfromreserved: false,moveToReserveredfalse
> 2013-05-31 20:00:52,944 DEBUG [cloud.capacity.CapacityManagerImpl]
> (Job-Executor-56:job-54) release mem from host: 3, old used:
> 1476395008,reserved: 0, total: 4066250752; new used: 939524096,reserved:0;
> movedfromreserved: fa
> lse,moveToReserveredfalse
> 2013-05-31 20:00:52,959 ERROR [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-56:job-54) Unexpected exception while executing
> org.apache.cloudstack.api.command.user.vm.StartVMCmd
> com.cloud.exception.AgentUnavailableException: Resource [Host:3] is
> unreachable: Host 3: Unable to start instance due to Unable to get answer
> that is of class com.cloud.agent.api.StartAnswer
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:937)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:550)
> at
> org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.deployVirtualMachine(VMEntityManagerImpl.java:243)
> at
> org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.deploy(VirtualMachineEntityImpl.java:209)
> at
> com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3243)
> at
> com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:1786)
> at
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
> at
> org.apache.cloudstack.api.command.user.vm.StartVMCmd.execute(StartVMCmd.java:120)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
> at
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
> at java.util.concurrent.FutureTask.run(FutureTask.java:166)
> 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)
> Caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to get
> answer that is of class com.cloud.agent.api.StartAnswer
> at com.cloud.agent.manager.Commands.getAnswer(Commands.java:80)
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:873)
> ... 19 more
> 2013-05-31 20:00:52,960 DEBUG [cloud.async.AsyncJobManagerImpl]
> (Job-Executor-56:job-54) Complete async job-54, jobStatus: 2, resultCode:
> 530, result: Error Code: 530 Error text: Resource [Host:3] is unreachable:
> Host 3: Una
> ble to start instance due to Unable to get answer that is of class
> com.cloud.agent.api.StartAnswer
> 2013-05-31 20:00:53,554 DEBUG [storage.secondary.SecondaryStorageManagerImpl]
> (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
--
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
