You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@cloudstack.apache.org by Koen Vanoppen <va...@gmail.com> on 2013/10/04 14:25:33 UTC

Problem when booting vm CS 4.2

Hi all,

I recently upgraded my CS from 4.1.1 to 4.2.
Now I have the following problem when creatin a new instance from my
templates.
When cloudstack starts to boot the instance I get the following error:
Unable to start instance due to InvocationTargetException when invoking RPC
callback for command: createVolumeFromBaseImageCallBack.

The template works fine (I did the upgrade in our test environment but used
the same templates).
I only added a shared network in the new cloudstack 4.2.

Kind regards,

Koen

Re: Problem when booting vm CS 4.2

Posted by Koen Vanoppen <va...@gmail.com>.
A portition from the log file. I destroyed the system vm's also, because
the agent state stayed on disconnnected...

2013-10-04 15:03:22,124 DEBUG [cloud.api.ApiServlet]
(catalina-exec-14:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891806602
2013-10-04 15:03:22,136 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-14:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:03:22,142 DEBUG [cloud.api.ApiServlet]
(catalina-exec-14:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891806602
2013-10-04 15:03:22,508 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Resetting hosts suitable for reconnect
2013-10-04 15:03:22,510 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Completed resetting hosts suitable for reconnect
2013-10-04 15:03:22,510 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Acquiring hosts for clusters already owned by this management
server
2013-10-04 15:03:22,511 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Completed acquiring hosts for clusters already owned by this
management server
2013-10-04 15:03:22,511 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Acquiring hosts for clusters not owned by any management server
2013-10-04 15:03:22,512 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager
Timer:null) Completed acquiring hosts for clusters not owned by any
management server
^C
[root@energia ~]# tail -f
/var/log/cloudstack/management/management-server.log
2013-10-04 15:03:49,155 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-7:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:03:49,160 DEBUG [cloud.api.ApiServlet] (catalina-exec-7:null)
===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891833609
2013-10-04 15:03:52,130 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null)
===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891836609
2013-10-04 15:03:52,142 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-9:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:03:52,148 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null)
===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891836609
2013-10-04 15:03:53,421 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-3:null) Ping from 3
2013-10-04 15:03:53,455 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-4:null) Ping from 1
2013-10-04 15:03:54,115 DEBUG [cloud.server.StatsCollector]
(StatsCollector-1:null) StorageCollector is running...
2013-10-04 15:03:54,119 INFO  [storage.endpoint.DefaultEndPointSelector]
(StatsCollector-1:null) No running ssvm is found, so command will be sent
to LocalHostEndPoint
2013-10-04 15:03:54,432 DEBUG [agent.transport.Request]
(StatsCollector-1:null) Seq 1-118423733: Received:  { Ans: , MgmtId:
345052353870, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
2013-10-04 15:03:55,131 DEBUG [cloud.api.ApiServlet]
(catalina-exec-19:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891839610
2013-10-04 15:03:55,143 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-19:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:03:55,149 DEBUG [cloud.api.ApiServlet]
(catalina-exec-19:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891839610
2013-10-04 15:03:58,131 DEBUG [cloud.api.ApiServlet]
(catalina-exec-15:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891842611
2013-10-04 15:03:58,143 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-15:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:03:58,149 DEBUG [cloud.api.ApiServlet]
(catalina-exec-15:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891842611
2013-10-04 15:04:01,131 DEBUG [cloud.api.ApiServlet]
(catalina-exec-17:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891845611
2013-10-04 15:04:01,143 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-17:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:01,149 DEBUG [cloud.api.ApiServlet]
(catalina-exec-17:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891845611
2013-10-04 15:04:03,444 DEBUG [cloud.server.StatsCollector]
(StatsCollector-1:null) VmStatsCollector is running...
2013-10-04 15:04:04,132 DEBUG [cloud.api.ApiServlet]
(catalina-exec-20:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891848612
2013-10-04 15:04:04,144 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-20:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:04,150 DEBUG [cloud.api.ApiServlet]
(catalina-exec-20:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891848612
2013-10-04 15:04:07,133 DEBUG [cloud.api.ApiServlet]
(catalina-exec-24:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891851612
2013-10-04 15:04:07,145 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-24:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:07,152 DEBUG [cloud.api.ApiServlet]
(catalina-exec-24:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891851612
2013-10-04 15:04:10,132 DEBUG [cloud.api.ApiServlet]
(catalina-exec-25:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891854613
2013-10-04 15:04:10,144 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-25:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:10,150 DEBUG [cloud.api.ApiServlet]
(catalina-exec-25:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891854613
2013-10-04 15:04:12,736 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) HostStatsCollector is running...
2013-10-04 15:04:13,133 DEBUG [cloud.api.ApiServlet]
(catalina-exec-18:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891857613
2013-10-04 15:04:13,145 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-18:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:13,151 DEBUG [cloud.api.ApiServlet]
(catalina-exec-18:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891857613
2013-10-04 15:04:13,348 DEBUG [agent.transport.Request]
(StatsCollector-3:null) Seq 1-118423734: Received:  { Ans: , MgmtId:
345052353870, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
2013-10-04 15:04:13,992 DEBUG [agent.transport.Request]
(StatsCollector-3:null) Seq 3-30605508: Received:  { Ans: , MgmtId:
345052353870, via: 3, Ver: v1, Flags: 10, { GetHostStatsAnswer } }
2013-10-04 15:04:16,134 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null)
===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891860614
2013-10-04 15:04:16,146 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-3:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:16,151 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null)
===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891860614
2013-10-04 15:04:17,275 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-10-04 15:04:17,277 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-10-04 15:04:17,388 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-10-04 15:04:17,390 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-10-04 15:04:19,134 DEBUG [cloud.api.ApiServlet]
(catalina-exec-21:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891863615
2013-10-04 15:04:19,155 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-21:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:19,164 DEBUG [cloud.api.ApiServlet]
(catalina-exec-21:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891863615
2013-10-04 15:04:20,202 INFO  [cloud.vm.UserVmManagerImpl]
(UserVm-Scavenger-1:null) Found 2 vms to expunge.
2013-10-04 15:04:20,202 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Stopped called on VM[User|Test] but the state is
Expunging
2013-10-04 15:04:20,207 DEBUG [cloud.capacity.CapacityManagerImpl]
(UserVm-Scavenger-1:null) VM state transitted from :Expunging to Expunging
with event: ExpungeOperationvm's original host id: null new host id: null
host id before state transition: null
2013-10-04 15:04:20,207 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Destroying vm VM[User|Test]
2013-10-04 15:04:20,207 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Cleaning up NICS
2013-10-04 15:04:20,207 DEBUG [cloud.network.NetworkManagerImpl]
(UserVm-Scavenger-1:null) Cleaning network for vm: 950
2013-10-04 15:04:20,212 DEBUG [cloud.network.NetworkModelImpl]
(UserVm-Scavenger-1:null) Service SecurityGroup is not supported in the
network id=207
2013-10-04 15:04:20,216 WARN  [cloud.vm.UserVmManagerImpl]
(UserVm-Scavenger-1:null) Unable to expunge VM[User|Test]
com.cloud.exception.UnsupportedServiceException: Service Dhcp is not
supported in the network id=207
    at
com.cloud.network.dao.NetworkServiceMapDaoImpl.getProviderForServiceInNetwork(NetworkServiceMapDaoImpl.java:127)
    at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
    at
com.cloud.network.NetworkManagerImpl.getDhcpServiceProvider(NetworkManagerImpl.java:3681)
    at
com.cloud.network.NetworkManagerImpl.isDhcpAccrossMultipleSubnetsSupported(NetworkManagerImpl.java:2522)
    at
com.cloud.network.NetworkManagerImpl.removeNic(NetworkManagerImpl.java:2507)
    at
com.cloud.network.NetworkManagerImpl.cleanupNics(NetworkManagerImpl.java:2463)
    at
com.cloud.vm.VirtualMachineManagerImpl.advanceExpunge(VirtualMachineManagerImpl.java:475)
    at com.cloud.vm.UserVmManagerImpl.expunge(UserVmManagerImpl.java:1600)
    at
com.cloud.vm.UserVmManagerImpl$ExpungeTask.run(UserVmManagerImpl.java:1769)
    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:1146)
    at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:679)
2013-10-04 15:04:20,217 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Stopped called on
VM[User|51d2fe45-5c6b-4fdf-9f2f-3adc0d0c7534] but the state is Expunging
2013-10-04 15:04:20,221 DEBUG [cloud.capacity.CapacityManagerImpl]
(UserVm-Scavenger-1:null) VM state transitted from :Expunging to Expunging
with event: ExpungeOperationvm's original host id: 3 new host id: null host
id before state transition: null
2013-10-04 15:04:20,221 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Destroying vm
VM[User|51d2fe45-5c6b-4fdf-9f2f-3adc0d0c7534]
2013-10-04 15:04:20,221 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(UserVm-Scavenger-1:null) Cleaning up NICS
2013-10-04 15:04:20,221 DEBUG [cloud.network.NetworkManagerImpl]
(UserVm-Scavenger-1:null) Cleaning network for vm: 951
2013-10-04 15:04:20,226 DEBUG [cloud.network.NetworkModelImpl]
(UserVm-Scavenger-1:null) Service SecurityGroup is not supported in the
network id=207
2013-10-04 15:04:20,230 WARN  [cloud.vm.UserVmManagerImpl]
(UserVm-Scavenger-1:null) Unable to expunge
VM[User|51d2fe45-5c6b-4fdf-9f2f-3adc0d0c7534]
com.cloud.exception.UnsupportedServiceException: Service Dhcp is not
supported in the network id=207
    at
com.cloud.network.dao.NetworkServiceMapDaoImpl.getProviderForServiceInNetwork(NetworkServiceMapDaoImpl.java:127)
    at
com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
    at
com.cloud.network.NetworkManagerImpl.getDhcpServiceProvider(NetworkManagerImpl.java:3681)
    at
com.cloud.network.NetworkManagerImpl.isDhcpAccrossMultipleSubnetsSupported(NetworkManagerImpl.java:2522)
    at
com.cloud.network.NetworkManagerImpl.removeNic(NetworkManagerImpl.java:2507)
    at
com.cloud.network.NetworkManagerImpl.cleanupNics(NetworkManagerImpl.java:2463)
    at
com.cloud.vm.VirtualMachineManagerImpl.advanceExpunge(VirtualMachineManagerImpl.java:475)
    at com.cloud.vm.UserVmManagerImpl.expunge(UserVmManagerImpl.java:1600)
    at
com.cloud.vm.UserVmManagerImpl$ExpungeTask.run(UserVmManagerImpl.java:1769)
    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:1146)
    at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
    at java.lang.Thread.run(Thread.java:679)
2013-10-04 15:04:22,138 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null)
===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891866619
2013-10-04 15:04:22,160 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-2:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:22,166 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null)
===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891866619
2013-10-04 15:04:25,139 DEBUG [cloud.api.ApiServlet] (catalina-exec-8:null)
===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891869619
2013-10-04 15:04:25,151 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-8:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:25,157 DEBUG [cloud.api.ApiServlet] (catalina-exec-8:null)
===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891869619
2013-10-04 15:04:28,140 DEBUG [cloud.api.ApiServlet]
(catalina-exec-13:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891872620
2013-10-04 15:04:28,153 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-13:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:28,160 DEBUG [cloud.api.ApiServlet]
(catalina-exec-13:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891872620
2013-10-04 15:04:31,141 DEBUG [cloud.api.ApiServlet]
(catalina-exec-11:null) ===START===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891875620
2013-10-04 15:04:31,153 DEBUG [cloud.async.AsyncJobManagerImpl]
(catalina-exec-11:null) Async job-42 = [
29b6068a-64f8-4cd4-9185-259627d612e9 ] completed
2013-10-04 15:04:31,158 DEBUG [cloud.api.ApiServlet]
(catalina-exec-11:null) ===END===  10.206.3.143 -- GET
command=queryAsyncJobResult&jobId=29b6068a-64f8-4cd4-9185-259627d612e9&response=json&sessionkey=zO9LsmrwSKr048Gqk3VEx%2Bw%2FZXM%3D&_=1380891875620



2013/10/4 Koen Vanoppen <va...@gmail.com>

> Hi all,
>
> I recently upgraded my CS from 4.1.1 to 4.2.
> Now I have the following problem when creatin a new instance from my
> templates.
> When cloudstack starts to boot the instance I get the following error:
> Unable to start instance due to InvocationTargetException when invoking
> RPC callback for command: createVolumeFromBaseImageCallBack.
>
> The template works fine (I did the upgrade in our test environment but
> used the same templates).
> I only added a shared network in the new cloudstack 4.2.
>
> Kind regards,
>
> Koen
>