incubator-cloudstack-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "shweta agarwal (JIRA)" <j...@apache.org>
Subject [jira] [Created] (CLOUDSTACK-183) hitting exception and system VM are not coming up
Date Fri, 21 Sep 2012 10:27:07 GMT
shweta agarwal created CLOUDSTACK-183:
-----------------------------------------

             Summary: hitting exception and system VM are not coming up
                 Key: CLOUDSTACK-183
                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-183
             Project: CloudStack
          Issue Type: Bug
          Components: Install and Setup
    Affects Versions: pre-4.0.0
         Environment: build:
Git Revision: 0699d65ef155aeff60aab294987815251cc94900
Git URL: https://git-wip-us.apache.org/repos/asf/incubator-cloudstack.git

            Reporter: shweta agarwal
            Priority: Blocker
             Fix For: pre-4.0.0
         Attachments: management-server.log, SMlog

I have xen6.0.2
I am trying to use build
http://jenkins.cloudstack.org/job/build-4.0-rhel63/55/artifact/CloudStack-oss-4.0.0-55.tar.bz2


hitting Exception MY MS log shows

2012-09-21 15:38:14,357 DEBUG [cloud.storage.StorageManagerImpl] (consoleproxy-1:null) Checking
if we need to prepare 1 volumes for VM[ConsoleProxy|v-2-VM]
2012-09-21 15:38:14,370 DEBUG [cloud.storage.StorageManagerImpl] (consoleproxy-1:null) Creating
volume: Vol[2|vm=2|ROOT]
2012-09-21 15:38:14,370 DEBUG [cloud.storage.StorageManagerImpl] (consoleproxy-1:null) Trying
to create in Pool[200|NetworkFilesystem]
2012-09-21 15:38:14,393 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Downloading
template 1 to pool 200
2012-09-21 15:38:14,408 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Downloading
1 via 1
2012-09-21 15:38:14,415 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493258:
Sending  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/6ce86454-a33f-3551-a1df-bf9cf191dded","poolUuid":"6ce86454-a33f-3551-a1df-bf9cf191dded","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfsecondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfprimary","url":"nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/","format":"VHD","accountId":1,"name":"routing-1","wait":10800}}]
}
2012-09-21 15:38:14,416 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493258:
Executing:  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/6ce86454-a33f-3551-a1df-bf9cf191dded","poolUuid":"6ce86454-a33f-3551-a1df-bf9cf191dded","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfsecondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfprimary","url":"nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/","format":"VHD","accountId":1,"name":"routing-1","wait":10800}}]
}
2012-09-21 15:38:14,416 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-5:null) Seq
1-1277493258: Executing request
2012-09-21 15:38:16,666 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-5:null) destoryVDIbyNameLabel
failed due to there are 0 VDIs with name cloud-4dd59ba5-e791-4289-9048-c925b28310ad
2012-09-21 15:38:16,666 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-5:null) can not
create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:16,667 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-5:null) Catch
Exception com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.copy_vhd_from_secondarystorage(CitrixResourceBase.java:2672)
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.execute(CitrixResourceBase.java:2694)
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:481)
	at com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:73)
	at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:191)
	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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
	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)
2012-09-21 15:38:16,667 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-5:null) Seq
1-1277493258: Response Received: 
2012-09-21 15:38:16,668 DEBUG [agent.transport.Request] (DirectAgent-5:null) Seq 1-1277493258:
Processing:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, [{"storage.PrimaryStorageDownloadAnswer":{"templateSize":0,"result":false,"details":"Catch
Exception com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef","wait":0}}]
}
2012-09-21 15:38:16,668 DEBUG [agent.manager.AgentAttache] (DirectAgent-5:null) Seq 1-1277493258:
No more commands found
2012-09-21 15:38:16,668 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493258:
Received:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, { PrimaryStorageDownloadAnswer
} }
2012-09-21 15:38:16,668 DEBUG [agent.manager.AgentManagerImpl] (consoleproxy-1:null) Details
from executing class com.cloud.agent.api.storage.PrimaryStorageDownloadCommand: Catch Exception
com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:16,668 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Template
1 download to pool 200 failed due to Catch Exception com.cloud.utils.exception.CloudRuntimeException
on host:186c239f-392e-4088-b5b2-03a4efc3c432 for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/
due to com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:16,668 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Downloading
1 via 1
2012-09-21 15:38:16,672 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493259:
Sending  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/6ce86454-a33f-3551-a1df-bf9cf191dded","poolUuid":"6ce86454-a33f-3551-a1df-bf9cf191dded","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfsecondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfprimary","url":"nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/","format":"VHD","accountId":1,"name":"routing-1","wait":10800}}]
}
2012-09-21 15:38:16,672 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493259:
Executing:  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"storage.PrimaryStorageDownloadCommand":{"localPath":"/mnt/6ce86454-a33f-3551-a1df-bf9cf191dded","poolUuid":"6ce86454-a33f-3551-a1df-bf9cf191dded","poolId":200,"secondaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfsecondary","primaryStorageUrl":"nfs://10.147.28.7/export/home/shweta/asfprimary","url":"nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/","format":"VHD","accountId":1,"name":"routing-1","wait":10800}}]
}
2012-09-21 15:38:16,672 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-2:null) Seq
1-1277493259: Executing request
2012-09-21 15:38:19,229 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is acquired for network id 200 as a part of network implement
2012-09-21 15:38:19,229 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Network
id=200 is already implemented
2012-09-21 15:38:19,230 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is released for network id 200 as a part of network implement
2012-09-21 15:38:19,257 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VirtualRouter to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
Ovs to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
ExternalDhcpServer to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
BareMetal to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
SecurityGroupProvider to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VpcVirtualRouter to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,258 WARN  [network.element.VpcVirtualRouterElement] (secstorage-1:null)
Network Ntwk[200|Public|1] is not associated with any VPC
2012-09-21 15:38:19,258 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
NiciraNvp to prepare for Nic[1-1-null-10.147.51.80]
2012-09-21 15:38:19,261 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is acquired for network id 202 as a part of network implement
2012-09-21 15:38:19,261 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Network
id=202 is already implemented
2012-09-21 15:38:19,262 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is released for network id 202 as a part of network implement
2012-09-21 15:38:19,297 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VirtualRouter to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
Ovs to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
ExternalDhcpServer to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
BareMetal to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
SecurityGroupProvider to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VpcVirtualRouter to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,298 WARN  [network.element.VpcVirtualRouterElement] (secstorage-1:null)
Network Ntwk[202|Control|3] is not associated with any VPC
2012-09-21 15:38:19,299 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
NiciraNvp to prepare for Nic[2-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-169.254.2.3]
2012-09-21 15:38:19,302 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is acquired for network id 201 as a part of network implement
2012-09-21 15:38:19,302 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Network
id=201 is already implemented
2012-09-21 15:38:19,303 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is released for network id 201 as a part of network implement
2012-09-21 15:38:19,335 DEBUG [network.guru.PodBasedNetworkGuru] (secstorage-1:null) Allocated
a nic NicProfile[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83-null for VM[SecondaryStorageVm|s-1-VM]
2012-09-21 15:38:19,341 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VirtualRouter to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
Ovs to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
ExternalDhcpServer to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
BareMetal to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
SecurityGroupProvider to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VpcVirtualRouter to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,342 WARN  [network.element.VpcVirtualRouterElement] (secstorage-1:null)
Network Ntwk[201|Management|2] is not associated with any VPC
2012-09-21 15:38:19,343 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
NiciraNvp to prepare for Nic[3-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.83]
2012-09-21 15:38:19,346 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is acquired for network id 203 as a part of network implement
2012-09-21 15:38:19,346 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Network
id=203 is already implemented
2012-09-21 15:38:19,347 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Lock
is released for network id 203 as a part of network implement
2012-09-21 15:38:19,375 DEBUG [network.guru.PodBasedNetworkGuru] (secstorage-1:null) Allocated
a nic NicProfile[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85-null for VM[SecondaryStorageVm|s-1-VM]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VirtualRouter to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
Ovs to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
ExternalDhcpServer to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
BareMetal to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
SecurityGroupProvider to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
VpcVirtualRouter to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,380 WARN  [network.element.VpcVirtualRouterElement] (secstorage-1:null)
Network Ntwk[203|Storage|4] is not associated with any VPC
2012-09-21 15:38:19,380 DEBUG [cloud.network.NetworkManagerImpl] (secstorage-1:null) Asking
NiciraNvp to prepare for Nic[4-1-e08d0ec0-3ce0-4612-8d2b-8df333117546-10.147.41.85]
2012-09-21 15:38:19,382 DEBUG [cloud.storage.StorageManagerImpl] (secstorage-1:null) Checking
if we need to prepare 1 volumes for VM[SecondaryStorageVm|s-1-VM]
2012-09-21 15:38:19,387 DEBUG [cloud.storage.StorageManagerImpl] (secstorage-1:null) Creating
volume: Vol[1|vm=1|ROOT]
2012-09-21 15:38:19,387 DEBUG [cloud.storage.StorageManagerImpl] (secstorage-1:null) Trying
to create in Pool[200|NetworkFilesystem]
2012-09-21 15:38:20,902 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-2:null) destoryVDIbyNameLabel
failed due to there are 0 VDIs with name cloud-9ebc9ab1-a421-4d24-8984-ea443c109491
2012-09-21 15:38:20,902 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-2:null) can not
create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:20,902 WARN  [xen.resource.CitrixResourceBase] (DirectAgent-2:null) Catch
Exception com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.copy_vhd_from_secondarystorage(CitrixResourceBase.java:2672)
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.execute(CitrixResourceBase.java:2694)
	at com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:481)
	at com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:73)
	at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:191)
	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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
	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)
2012-09-21 15:38:20,904 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-2:null) Seq
1-1277493259: Response Received: 
2012-09-21 15:38:20,904 DEBUG [agent.transport.Request] (DirectAgent-2:null) Seq 1-1277493259:
Processing:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, [{"storage.PrimaryStorageDownloadAnswer":{"templateSize":0,"result":false,"details":"Catch
Exception com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef","wait":0}}]
}
2012-09-21 15:38:20,905 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493259:
Received:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, { PrimaryStorageDownloadAnswer
} }
2012-09-21 15:38:20,905 DEBUG [agent.manager.AgentManagerImpl] (consoleproxy-1:null) Details
from executing class com.cloud.agent.api.storage.PrimaryStorageDownloadCommand: Catch Exception
com.cloud.utils.exception.CloudRuntimeException on host:186c239f-392e-4088-b5b2-03a4efc3c432
for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/ due to
com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:20,905 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Template
1 download to pool 200 failed due to Catch Exception com.cloud.utils.exception.CloudRuntimeException
on host:186c239f-392e-4088-b5b2-03a4efc3c432 for template: nfs://10.147.28.7/export/home/shweta/asfsecondary/template/tmpl/1/1/
due to com.cloud.utils.exception.CloudRuntimeException: can not create vdi in sr 7978e087-b632-8349-78e7-d3c6e7effeef
2012-09-21 15:38:20,905 DEBUG [agent.manager.AgentAttache] (DirectAgent-2:null) Seq 1-1277493259:
No more commands found
2012-09-21 15:38:20,906 DEBUG [cloud.template.TemplateManagerImpl] (consoleproxy-1:null) Template
1 is not found on and can not be downloaded to pool 200
2012-09-21 15:38:20,906 DEBUG [cloud.storage.StorageManagerImpl] (consoleproxy-1:null) Cannot
use this pool Pool[200|NetworkFilesystem] because we can't propagate template Tmpl[1-VHD-routing-1
2012-09-21 15:38:20,912 INFO  [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Unable
to contact resource.
com.cloud.exception.StorageUnavailableException: Resource [StoragePool:200] is unreachable:
Unable to create Vol[2|vm=2|ROOT]
	at com.cloud.storage.StorageManagerImpl.prepare(StorageManagerImpl.java:3361)
	at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:754)
	at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:472)
	at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:465)
	at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:624)
	at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1154)
	at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1965)
	at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:170)
	at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:113)
	at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:34)
	at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:83)
	at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:73)
	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)
2012-09-21 15:38:20,918 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Cleaning
up resources for the vm VM[ConsoleProxy|v-2-VM] in Starting state
2012-09-21 15:38:20,922 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493260:
Sending  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"v-2-VM","wait":0}}]
}
2012-09-21 15:38:20,922 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493260:
Executing:  { Cmd , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 100111, [{"StopCommand":{"isProxy":false,"vmName":"v-2-VM","wait":0}}]
}
2012-09-21 15:38:20,922 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-6:null) Seq
1-1277493260: Executing request
2012-09-21 15:38:21,019 INFO  [xen.resource.CitrixResourceBase] (DirectAgent-6:null) VM does
not exist on XenServer186c239f-392e-4088-b5b2-03a4efc3c432
2012-09-21 15:38:21,019 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-6:null) Seq
1-1277493260: Response Received: 
2012-09-21 15:38:21,020 DEBUG [agent.transport.Request] (DirectAgent-6:null) Seq 1-1277493260:
Processing:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, [{"StopAnswer":{"vncPort":0,"result":true,"details":"VM
does not exist","wait":0}}] }
2012-09-21 15:38:21,020 DEBUG [agent.manager.AgentAttache] (DirectAgent-6:null) Seq 1-1277493260:
No more commands found
2012-09-21 15:38:21,021 DEBUG [agent.transport.Request] (consoleproxy-1:null) Seq 1-1277493260:
Received:  { Ans: , MgmtId: 59793358248320, via: 1, Ver: v1, Flags: 110, { StopAnswer } }
2012-09-21 15:38:21,050 DEBUG [network.guru.ControlNetworkGuru] (consoleproxy-1:null) Released
nic: NicProfile[6-2-null-null-null
2012-09-21 15:38:21,055 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking
VirtualRouter to release 

Attaching MS log

SMlog


When executing
 /opt/xensource/bin/copy_vhd_from_secondarystorage.sh 10.147.28.7:/export/home/shweta/asfsecondary/template/tmpl/1/1/
7978e087-b632-8349-78e7-d3c6e7effeef  cloud-d4969150-9a80-4b5b-b87c-fed6a15b39bc

Getting exception
/opt/xensource/bin/vhd-util query -v -n /var/run/cloud_mount/f0072628-7275-46f9-a715-6775b8af905a//d90f2df0-f44b-4b1d-ba8a-d33788720158.vhd
/opt/xensource/bin/copy_vhd_from_secondarystorage.sh: line 133: /opt/xensource/bin/vhd-util:
No such file or directory




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