Cesar Trujillo created CLOUDSTACK-4463:
------------------------------------------
Summary: Cloudstack 4.1.0 Issue: Zone 1 is not ready to launch
secondary storage VM yet
Key: CLOUDSTACK-4463
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-4463
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Environment: cloudstack 4.1.0 on Centos 6.4
Reporter: Cesar Trujillo
Hello,
I have an issue with CloudStack. I install CloudStack 4.1.0 on Centos 6.4. I
made a basic deployment. This is a small part of the log file:
2013-08-22 15:56:08,899 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-08-22 15:56:24,203 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) VmStatsCollector is running...
2013-08-22 15:56:25,346 DEBUG [cloud.server.StatsCollector]
(StatsCollector-1:null) HostStatsCollector is running...
2013-08-22 15:56:25,362 DEBUG [agent.manager.ClusteredAgentAttache]
(StatsCollector-1:null) Seq 1-1452867649: Forwarding null to 148379010398218
2013-08-22 15:56:25,363 DEBUG [agent.manager.ClusteredAgentAttache]
(AgentManager-Handler-11:null) Seq 1-1452867649: Routing from 275327716248840
2013-08-22 15:56:25,363 DEBUG [agent.manager.ClusteredAgentAttache]
(AgentManager-Handler-11:null) Seq 1-1452867649: Link is closed
2013-08-22 15:56:25,363 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-11:null) Seq 1-1452867649: MgmtId 275327716248840: Req:
Resource [Host:1]
is unreachable: Host 1: Link is closed
2013-08-22 15:56:25,363 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-11:null) Seq 1--1: MgmtId 275327716248840: Req: Routing
to peer
2013-08-22 15:56:25,364 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-12:null) Seq 1--1: MgmtId 275327716248840: Req: Cancel
request received
2013-08-22 15:56:25,364 DEBUG [agent.manager.AgentAttache]
(AgentManager-Handler-12:null) Seq 1-1452867649: Cancelling.
2013-08-22 15:56:25,364 DEBUG [agent.manager.AgentAttache]
(StatsCollector-1:null) Seq 1-1452867649: Waiting some more time because this
is the current command
2013-08-22 15:56:25,364 DEBUG [agent.manager.AgentAttache]
(StatsCollector-1:null) Seq 1-1452867649: Waiting some more time because this
is the current command
2013-08-22 15:56:25,364 INFO [utils.exception.CSExceptionErrorCode]
(StatsCollector-1:null) Could not find exception:
com.cloud.exception.OperationTimedoutException in
error code list for exceptions
2013-08-22 15:56:25,364 WARN [agent.manager.AgentAttache]
(StatsCollector-1:null) Seq 1-1452867649: Timed out on null
2013-08-22 15:56:25,365 DEBUG [agent.manager.AgentAttache]
(StatsCollector-1:null) Seq 1-1452867649: Cancelling.
2013-08-22 15:56:25,365 WARN [agent.manager.AgentManagerImpl]
(StatsCollector-1:null) Operation timed out: Commands 1452867649 to Host 1
timed out after 3600
2013-08-22 15:56:25,365 WARN [cloud.resource.ResourceManagerImpl]
(StatsCollector-1:null) Unable to obtain host 1 statistics.
2013-08-22 15:56:25,365 WARN [cloud.server.StatsCollector]
(StatsCollector-1:null) Received invalid host stats for host: 1
2013-08-22 15:56:25,395 DEBUG [cloud.server.StatsCollector]
(StatsCollector-2:null) StorageCollector is running...
2013-08-22 15:56:25,401 DEBUG [cloud.server.StatsCollector]
(StatsCollector-2:null) There is no secondary storage VM for secondary storage
host nfs://172.30.30.20/export/secondary
2013-08-22 15:56:25,417 DEBUG [agent.manager.ClusteredAgentAttache]
(StatsCollector-2:null) Seq 1-1452867650: Forwarding null to 148379010398218
2013-08-22 15:56:25,419 DEBUG [agent.manager.ClusteredAgentAttache]
(AgentManager-Handler-13:null) Seq 1-1452867650: Routing from 275327716248840
2013-08-22 15:56:25,419 DEBUG [agent.manager.ClusteredAgentAttache]
(AgentManager-Handler-13:null) Seq 1-1452867650: Link is closed
2013-08-22 15:56:25,419 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-13:null) Seq 1-1452867650: MgmtId 275327716248840: Req:
Resource [Host:1]
is unreachable: Host 1: Link is closed
2013-08-22 15:56:25,420 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-13:null) Seq 1--1: MgmtId 275327716248840: Req: Routing
to peer
2013-08-22 15:56:25,421 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(AgentManager-Handler-15:null) Seq 1--1: MgmtId 275327716248840: Req: Cancel
request received
2013-08-22 15:56:25,421 DEBUG [agent.manager.AgentAttache]
(AgentManager-Handler-15:null) Seq 1-1452867650: Cancelling.
2013-08-22 15:56:25,421 DEBUG [agent.manager.AgentAttache]
(StatsCollector-2:null) Seq 1-1452867650: Waiting some more time because this
is the current command
2013-08-22 15:56:25,421 DEBUG [agent.manager.AgentAttache]
(StatsCollector-2:null) Seq 1-1452867650: Waiting some more time because this
is the current command
2013-08-22 15:56:25,422 INFO [utils.exception.CSExceptionErrorCode]
(StatsCollector-2:null) Could not find exception:
com.cloud.exception.OperationTimedoutException in
error code list for exceptions
2013-08-22 15:56:25,422 WARN [agent.manager.AgentAttache]
(StatsCollector-2:null) Seq 1-1452867650: Timed out on null
2013-08-22 15:56:25,422 DEBUG [agent.manager.AgentAttache]
(StatsCollector-2:null) Seq 1-1452867650: Cancelling.
2013-08-22 15:56:25,422 DEBUG [cloud.storage.StorageManagerImpl]
(StatsCollector-2:null) Unable to send storage pool command to Pool[200|LVM]
via 1
com.cloud.exception.OperationTimedoutException: Commands 1452867650 to Host 1
timed out after 3600
at com.cloud.agent.manager.AgentAttache.send(AgentAttache.java:429)
at
com.cloud.agent.manager.AgentManagerImpl.send(AgentManagerImpl.java:511)
at
com.cloud.agent.manager.AgentManagerImpl.send(AgentManagerImpl.java:464)
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:2347)
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:422)
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:436)
at
com.cloud.server.StatsCollector$StorageCollector.run(StatsCollector.java:316)
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-08-22 15:56:25,423 INFO [cloud.server.StatsCollector]
(StatsCollector-2:null) Unable to reach Pool[200|LVM]
com.cloud.exception.StorageUnavailableException: Resource [StoragePool:200] is
unreachable: Unable to send command to the pool
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:2357)
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:422)
at
com.cloud.storage.StorageManagerImpl.sendToPool(StorageManagerImpl.java:436)
at
com.cloud.server.StatsCollector$StorageCollector.run(StatsCollector.java:316)
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-08-22 15:56:37,528 DEBUG [storage.secondary.SecondaryStorageManagerImpl]
(secstorage-1:null) Zone 1 is not ready to launch secondary storage VM yet
2013-08-22 15:56:38,122 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(consoleproxy-1:null) Zone 1 is not ready to launch console proxy yet
2013-08-22 15:56:38,885 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-08-22 15:56:38,887 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
2013-08-22 15:56:38,895 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers to update status.
2013-08-22 15:56:38,896 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
--
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
