Return-Path: X-Original-To: apmail-cloudstack-users-cn-archive@www.apache.org Delivered-To: apmail-cloudstack-users-cn-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 0B551172EA for ; Tue, 24 Mar 2015 08:51:21 +0000 (UTC) Received: (qmail 66043 invoked by uid 500); 24 Mar 2015 08:51:20 -0000 Delivered-To: apmail-cloudstack-users-cn-archive@cloudstack.apache.org Received: (qmail 66006 invoked by uid 500); 24 Mar 2015 08:51:20 -0000 Mailing-List: contact users-cn-help@cloudstack.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: users-cn@cloudstack.apache.org Delivered-To: mailing list users-cn@cloudstack.apache.org Received: (qmail 65990 invoked by uid 99); 24 Mar 2015 08:51:20 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 24 Mar 2015 08:51:20 +0000 X-ASF-Spam-Status: No, hits=0.0 required=5.0 tests=SPF_PASS,UNPARSEABLE_RELAY X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: domain of starg@ceph.me designates 42.120.134.138 as permitted sender) Received: from [42.120.134.138] (HELO out1134-138.mail.aliyun.com) (42.120.134.138) by apache.org (qpsmtpd/0.29) with ESMTP; Tue, 24 Mar 2015 08:51:14 +0000 X-Alimail-AntiSpam: AC=CONTINUE;BC=0.07437621|-1;FP=0|0|0|0|0|-1|-1|-1;HT=r41g03020;MF=starg@ceph.me;PH=DS;RN=1;RT=1;SR=0; Received: from starpc(mailfrom:starg@ceph.me ip:183.63.83.12) by smtp.aliyun-inc.com(10.147.34.64); Tue, 24 Mar 2015 16:50:37 +0800 From: "Star Guo" To: References: In-Reply-To: Subject: =?gb2312?B?tPC4tDogz7XNs9DpxOK7+mFnZW50IHN0YXRl0rvWsc6qv9U=?= Date: Tue, 24 Mar 2015 16:50:32 +0800 Message-ID: <009201d0660f$98dcbc90$ca9635b0$@ceph.me> MIME-Version: 1.0 Content-Type: text/plain; charset="gb2312" Content-Transfer-Encoding: quoted-printable X-Mailer: Microsoft Outlook 14.0 Thread-Index: AQDeCGS0J0kxe6CLLDGrBoEkA4wMZp8QDdog Content-Language: zh-cn X-Virus-Checked: Checked by ClamAV on apache.org Hi, = =C7=EB=CE=CA=C4=E3=CA=C7=CA=B9=D3=C3=BB=F9=B4=A1=CD=F8=C2=E7=A3=AC=BB=B9=CA= =C7=B8=DF=BC=B6=CD=F8=C2=E7=A3=BF = =C8=E7=B9=FB=C4=E3=D2=AA=CA=B9=D3=C3=B8=DF=BC=B6=CD=F8=C2=E7=A3=AC=B0=B4=D5= =D5=B9=E6=B7=B6=C4=E3=D2=AA =C5=E4=D6=C3=D4=DAxenserver=C9=CF=C3=E6=C5=E4=D6=C3=C1=BD=B8=F6=CD=F8=C2=E7= =A3=BA=B9=DC=C0=ED=CD=F8=C2=E7=BA=CDguset/public=CD=F8=C2=E7=A3=AC=C7=B0=D5= =DFaccess mode =BA=F3=D5=DFtrunk mode=A1=A3 Best Regards, Star Guo -----=D3=CA=BC=FE=D4=AD=BC=FE----- =B7=A2=BC=FE=C8=CB: =BD=AA=CE=C0=B6=AB = [mailto:jiang.weidong@foxmail.com]=20 =B7=A2=CB=CD=CA=B1=BC=E4: 2015=C4=EA3=D4=C223=C8=D5 19:01 =CA=D5=BC=FE=C8=CB: users-cn =D6=F7=CC=E2: =CF=B5=CD=B3=D0=E9=C4=E2=BB=FAagent = state=D2=BB=D6=B1=CE=AA=BF=D5 =BF=B4=B5=BD=D3=CA=BC=FE=B5=C4=C5=F3=D3=D1=C4=E3=C3=C7=BA=C3=A3=BA = =CE=D2=D4=DA=B0=B2=D7=B0=B2=E2=CA=D4cloudstack=BA=CDxenserver=B5=C4=CA=B1= =BA=F2=D3=F6=B5=BD=C1=CB=D2=BB=D0=A9=CE=CA=CC=E2=A3=AC=CF=A3=CD=FB=D3=D0=C5= =F3=D3=D1=C4=DC=B0=EF=CE=D2 =B7=D6=CE=F6=D2=BB=CF=C2=D4=AD=D2=F2=A1=A3 =C8=E7=CF=C2=CE=CA=CC=E2=A3=BA =CF=B5=CD=B3=D0=E9=C4=E2=BB=FA=C6=F4=B6=AF=D6=AE=BA=F3agent = state=D7=B4=CC=AC=D2=BB=D6=B1=CE=AA=BF=D5=A1=A3=C8=D5=D6=BE=CC=E1=CA=BE = =A3=BAPing timeout for host 1 =CE=D2=B5=C4=CF=B5=CD=B3=C5=E4=D6=C3=C8=E7=CF=C2=A3=BA =BD=BB=BB=BB=BB=FA=A3=BA=C8=FD=B8=F6=C7=F8=D3=F2 1.=D2=BB=B8=F6=B9=AB=CD=F8 vlan 20=A3=ACaccess 2.=D2=BB=B8=F6=B9=DC=C0=EDvlan 10 =A3=AC10.10.10.0/24,access = 3.=D2=BB=B8=F6=B9=DC=C0=ED=BA=CD=C0=B4=B1=F6=B5=C4=B9=AB=D3=C3=C7=F8=D3=F2= , vlan 10,vlan30-50,trunk,=C4=AC=C8=CFvlan10 =B6=D4=B9=DC=C0=ED=CD=F8=C2=E7=D7=F6=C1=CBvlanif,ip 10.10.10.1=A3=AC = =BF=C9=C9=CF=CD=F8=B5=C4=C9=CF=B2=E3=BD=BB=BB=BB=BB=FA=C1=AC=BD=D3=B5=BDv= lan20,=CD=F8=B9=D8=A3=BA192.169.2.253=A3=AC255.255.0.0. =B9=DC=C0=ED=BB=FAcloudstack4.2=A3=BAubuntu12.04,mysql,ntpd = eth0=A3=BA10.10.10.2=A3=AC255.255.255.0,=CD=F8=B9=D8=A3=BA10.10.10.1=A3=AC= dns:10.10.10.3 eth1: = 192.169.77.2,255.255.0.0,=CD=F8=B9=D8=A3=BA192.169.2.253=A3=ACdns=A3=BA19= 2.169.2.253 nfs: ubuntu12.04,nfs,dns = eth0:10.10.10.3,255.255.255.0,=CD=F8=B9=D8=A3=BA10.10.10.1=A3=ACdns:10.10= .10.3 =BC=C6=CB=E3=BD=DA=B5=E3xenserver6.2: = eth0:10.10.10.11,=CD=F8=B9=D8=A3=BA10.10.10.1=A3=ACdns:10.10.10.3=A3=AC=B1= =EA=C7=A9network0 eth1:=C9=B6=B6=BC=C3=BB=C5=E4=A3=AC=B1=EA=C7=A9network1 =CF=C2=B1=DF=CA=C7=B4=ED=CE=F3=C8=D5=D6=BE=A3=BA=D2=BB=D6=B1=D1=AD=BB=B7=B3= =F6=CF=D6=CF=C2=B1=DF=B5=C4=C8=D5=D6=BE=C7=E9=BF=F6 2015-03-23 18:36:48,381 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-30a758f4) Zone 1 is ready to launch console proxy 2015-03-23 18:36:48,518 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-4613b985) Zone 1 is ready to launch secondary storage = VM 2015-03-23 18:36:54,540 DEBUG [c.c.s.StatsCollector] (StatsCollector-4:ctx-dc70f3fd) AutoScaling Monitor is running... 2015-03-23 18:36:54,572 DEBUG [c.c.s.StatsCollector] (StatsCollector-1:ctx-cd4ca6c9) VmStatsCollector is running... 2015-03-23 18:36:55,061 DEBUG [c.c.s.StatsCollector] (StatsCollector-2:ctx-f2ba1db3) HostStatsCollector is running... 2015-03-23 18:36:55,069 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-14:ctx-7cb5c18e) Seq 1-67272519433846836: Executing request 2015-03-23 18:36:55,094 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-14:ctx-7cb5c18e) Seq 1-67272519433846836: Response = Received: 2015-03-23 18:36:55,095 DEBUG [c.c.a.t.Request] (StatsCollector-2:ctx-f2ba1db3) Seq 1-67272519433846836: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer = } } 2015-03-23 18:37:00,042 WARN [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-12:ctx-fec36132) Unable to get current status on = 1(xs11. cs.com) 2015-03-23 18:37:00,115 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-f4732348) StorageCollector is running... 2015-03-23 18:37:00,119 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-f4732348) There is no secondary storage VM for secondary storage host secondary1 2015-03-23 18:37:00,122 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-27:ctx-eb12616b) Seq 1-67272519433846837: Executing request 2015-03-23 18:37:00,451 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-27:ctx-eb12616b) Seq 1-67272519433846837: Response = Received: 2015-03-23 18:37:00,451 DEBUG [c.c.a.t.Request] (StatsCollector-3:ctx-f4732348) Seq 1-67272519433846837: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { = GetStorageStatsAnswer } } 2015-03-23 18:37:09,560 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-409a1826) Found 0 routers to update status. 2015-03-23 18:37:09,561 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-409a1826) Found 0 networks to update RvR = status. 2015-03-23 18:37:18,381 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-8efc34c1) Zone 1 is ready to launch console proxy 2015-03-23 18:37:18,518 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-43e9f234) Zone 1 is ready to launch secondary storage = VM 2015-03-23 18:37:39,515 DEBUG [c.c.n.ExternalDeviceUsageManagerImpl] (ExternalNetworkMonitor-1:ctx-55964f6a) External devices stats collector = is running... 2015-03-23 18:37:39,559 DEBUG [c.c.s.s.SnapshotSchedulerImpl] (SnapshotPollTask:ctx-5b25e4fe) Snapshot scheduler.poll is being called = at 2015-03-23 10:37:39 GMT 2015-03-23 18:37:39,559 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterMonitor-1:ctx-424c44e3) Found 0 running routers. 2015-03-23 18:37:39,560 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-52d7fa48) Found 0 routers to update status. 2015-03-23 18:37:39,561 DEBUG [c.c.s.s.SnapshotSchedulerImpl] (SnapshotPollTask:ctx-5b25e4fe) Got 0 snapshots to be executed at = 2015-03-23 10:37:39 GMT 2015-03-23 18:37:39,561 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-52d7fa48) Found 0 networks to update RvR = status. 2015-03-23 18:37:39,645 INFO [c.c.a.m.AgentManagerImpl] (AgentMonitor-1:ctx-c7abd581) Found the following agents behind on ping: = [1] 2015-03-23 18:37:39,646 DEBUG [c.c.h.Status] = (AgentMonitor-1:ctx-c7abd581) Ping timeout for host 1, do invstigation 2015-03-23 18:37:39,649 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) Investigating why host 1 has = disconnected with event PingTimeout 2015-03-23 18:37:39,649 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) checking if agent (1) is alive 2015-03-23 18:37:39,652 DEBUG [c.c.a.t.Request] (AgentTaskPool-12:ctx-08432615) Seq 1-67272519433846838: Sending { Cmd = , MgmtId: 92378953757938, via: 1(xs11.cs.com), Ver: v1, Flags: 100011, = [{"com. cloud.agent.api.CheckHealthCommand":{"wait":50}}] } 2015-03-23 18:37:39,652 DEBUG [c.c.a.t.Request] (AgentTaskPool-12:ctx-08432615) Seq 1-67272519433846838: Executing: { = Cmd , MgmtId: 92378953757938, via: 1(xs11.cs.com), Ver: v1, Flags: 100011, = [{"com. cloud.agent.api.CheckHealthCommand":{"wait":50}}] } 2015-03-23 18:37:39,653 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-4:ctx-a57f6222) Seq 1-67272519433846838: Executing request 2015-03-23 18:37:39,733 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-4:ctx-a57f6222) Seq 1-67272519433846838: Response Received: 2015-03-23 18:37:39,734 DEBUG [c.c.a.t.Request] = (DirectAgent-4:ctx-a57f6222) Seq 1-67272519433846838: Processing: { Ans: , MgmtId: 92378953757938, = via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.CheckHealthAnswer":{"result":true,"details":"resou= rce is alive","wait":0}}] } 2015-03-23 18:37:39,734 DEBUG [c.c.a.t.Request] (AgentTaskPool-12:ctx-08432615) Seq 1-67272519433846838: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { CheckHealthAnswer = } } 2015-03-23 18:37:39,734 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) Details from executing class com.cloud.agent.api.CheckHealthCommand: resource is alive 2015-03-23 18:37:39,734 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) agent (1) responded to = checkHeathCommand, reporting that agent is Up 2015-03-23 18:37:39,734 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) The state determined is Up 2015-03-23 18:37:39,734 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-12:ctx-08432615) Agent is determined to be up and running 2015-03-23 18:37:39,734 DEBUG [c.c.h.Status] = (AgentTaskPool-12:ctx-08432615) Transition:[Resource state =3D Enabled, Agent event =3D Ping, Host id = =3D 1, name =3D xs11.cs.com] 2015-03-23 18:37:48,380 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-cdc607bf) Zone 1 is ready to launch console proxy 2015-03-23 18:37:48,518 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-97fa4f0a) Zone 1 is ready to launch secondary storage = VM 2015-03-23 18:37:54,541 DEBUG [c.c.s.StatsCollector] (StatsCollector-4:ctx-39eb8214) AutoScaling Monitor is running... 2015-03-23 18:37:54,575 DEBUG [c.c.s.StatsCollector] (StatsCollector-1:ctx-3b39f908) VmStatsCollector is running... 2015-03-23 18:37:55,096 DEBUG [c.c.s.StatsCollector] (StatsCollector-2:ctx-430189e4) HostStatsCollector is running... 2015-03-23 18:37:55,104 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-28:ctx-ea62d64b) Seq 1-67272519433846839: Executing request 2015-03-23 18:37:55,130 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-28:ctx-ea62d64b) Seq 1-67272519433846839: Response = Received: 2015-03-23 18:37:55,130 DEBUG [c.c.a.t.Request] (StatsCollector-2:ctx-430189e4) Seq 1-67272519433846839: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer = } } 2015-03-23 18:38:00,042 WARN [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-13:ctx-34eb4bed) Unable to get current status on = 1(xs11. cs.com) 2015-03-23 18:38:00,452 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-ffcb2150) StorageCollector is running... 2015-03-23 18:38:00,455 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-ffcb2150) There is no secondary storage VM for secondary storage host secondary1 2015-03-23 18:38:00,458 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-15:ctx-22e2fd27) Seq 1-67272519433846840: Executing request 2015-03-23 18:38:00,776 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-15:ctx-22e2fd27) Seq 1-67272519433846840: Response = Received: 2015-03-23 18:38:00,776 DEBUG [c.c.a.t.Request] (StatsCollector-3:ctx-ffcb2150) Seq 1-67272519433846840: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { = GetStorageStatsAnswer } } 2015-03-23 18:38:09,258 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-8:ctx-97fcdb6b) Seq 1-67272519433846787: Executing request 2015-03-23 18:38:09,417 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-8:ctx-97fcdb6b) Seq 1-67272519433846787: Response Received: 2015-03-23 18:38:09,418 DEBUG [c.c.a.t.Request] (DirectAgentCronJob-8:ctx-97fcdb6b) Seq 1-67272519433846787: Processing: = { Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.ClusterVMMetaDataSyncAnswer":{"_clusterId":1,"_vmM= eta Datum":{"v-1-VM":"viridian:true;acpi:1;apic:true;pae:true;nx:true","s-2-V= M": "viridian:true;acpi:1;apic:true;pae:true;nx:true"},"_isExecuted":false,"r= esu lt":true,"wait":0}}] } 2015-03-23 18:38:09,493 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (HostReservationReleaseChecker:ctx-bae7c4ee) Checking if any host reservation can be released ... 2015-03-23 18:38:09,495 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Running Capacity Checker ... 2015-03-23 18:38:09,495 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) recalculating system capacity 2015-03-23 18:38:09,495 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Executing cpu/ram capacity update 2015-03-23 18:38:09,499 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (HostReservationReleaseChecker:ctx-bae7c4ee) Cannot release reservation, Found 2 VMs Running on host 1 2015-03-23 18:38:09,499 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (HostReservationReleaseChecker:ctx-bae7c4ee) Done running HostReservationReleaseChecker ... 2015-03-23 18:38:09,501 DEBUG [c.c.c.CapacityManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Found 2 VMs on host 1 2015-03-23 18:38:09,504 DEBUG [c.c.c.CapacityManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Found 0 VM, not running on host 1 2015-03-23 18:38:09,505 DEBUG [c.c.c.CapacityManagerImpl] (CapacityChecker:ctx-c2ce1ba8) No need to calibrate cpu capacity, host:1 usedCpu: 1000 reservedCpu: 0 2015-03-23 18:38:09,505 DEBUG [c.c.c.CapacityManagerImpl] (CapacityChecker:ctx-c2ce1ba8) No need to calibrate memory capacity, = host:1 usedMem: 1610612736 reservedMem: 0 2015-03-23 18:38:09,560 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-34219ead) Found 0 routers to update status. 2015-03-23 18:38:09,561 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-34219ead) Found 0 networks to update RvR = status. 2015-03-23 18:38:09,589 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done executing cpu/ram capacity update 2015-03-23 18:38:09,589 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Executing storage capacity update 2015-03-23 18:38:09,592 DEBUG [c.c.s.StorageManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Found storage pool xs11-p1 of type = PreSetup 2015-03-23 18:38:09,592 DEBUG [c.c.s.StorageManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Total over provisioned capacity of the = pool xs11-p1 id: 1 is 17990976274432 2015-03-23 18:38:09,672 DEBUG [c.c.s.StorageManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Successfully set Capacity - = 17990976274432 for capacity type - 3 , DataCenterId - 1, HostOrPoolId - 1, PodId 1 2015-03-23 18:38:09,672 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done executing storage capacity update 2015-03-23 18:38:09,672 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Executing capacity updates for public ip = and Vlans 2015-03-23 18:38:09,685 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done capacity updates for public ip and = Vlans 2015-03-23 18:38:09,685 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Executing capacity updates for private ip 2015-03-23 18:38:09,690 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done executing capacity updates for = private ip 2015-03-23 18:38:09,690 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done recalculating system capacity 2015-03-23 18:38:09,704 DEBUG [c.c.a.AlertManagerImpl] (CapacityChecker:ctx-c2ce1ba8) Done running Capacity Checker ... 2015-03-23 18:38:14,531 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Resetting hosts suitable for reconnect 2015-03-23 18:38:14,532 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Completed resetting hosts suitable for reconnect 2015-03-23 18:38:14,532 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Acquiring hosts for clusters already owned by this management server 2015-03-23 18:38:14,533 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Completed acquiring hosts for clusters already owned = by this management server 2015-03-23 18:38:14,533 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Acquiring hosts for clusters not owned by any = management server 2015-03-23 18:38:14,534 DEBUG [c.c.h.d.HostDaoImpl] = (ClusteredAgentManager Timer:ctx-0b85bd4d) Completed acquiring hosts for clusters not owned by = any management server 2015-03-23 18:38:18,382 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-7fbf4f6c) Zone 1 is ready to launch console proxy 2015-03-23 18:38:18,518 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-1c87138f) Zone 1 is ready to launch secondary storage = VM 2015-03-23 18:38:39,560 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-bc222fd1) Found 0 routers to update status. 2015-03-23 18:38:39,562 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-bc222fd1) Found 0 networks to update RvR = status. 2015-03-23 18:38:39,649 INFO [c.c.a.m.AgentManagerImpl] (AgentMonitor-1:ctx-087b4bf4) Found the following agents behind on ping: = [1] 2015-03-23 18:38:39,651 DEBUG [c.c.h.Status] = (AgentMonitor-1:ctx-087b4bf4) Ping timeout for host 1, do invstigation 2015-03-23 18:38:39,653 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) Investigating why host 1 has = disconnected with event PingTimeout 2015-03-23 18:38:39,653 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) checking if agent (1) is alive 2015-03-23 18:38:39,656 DEBUG [c.c.a.t.Request] (AgentTaskPool-13:ctx-add211c0) Seq 1-67272519433846841: Sending { Cmd = , MgmtId: 92378953757938, via: 1(xs11.cs.com), Ver: v1, Flags: 100011, = [{"com. cloud.agent.api.CheckHealthCommand":{"wait":50}}] } 2015-03-23 18:38:39,656 DEBUG [c.c.a.t.Request] (AgentTaskPool-13:ctx-add211c0) Seq 1-67272519433846841: Executing: { = Cmd , MgmtId: 92378953757938, via: 1(xs11.cs.com), Ver: v1, Flags: 100011, = [{"com. cloud.agent.api.CheckHealthCommand":{"wait":50}}] } 2015-03-23 18:38:39,656 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-29:ctx-f86e1b5f) Seq 1-67272519433846841: Executing request 2015-03-23 18:38:39,739 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-29:ctx-f86e1b5f) Seq 1-67272519433846841: Response = Received: 2015-03-23 18:38:39,739 DEBUG [c.c.a.t.Request] (DirectAgent-29:ctx-f86e1b5f) Seq 1-67272519433846841: Processing: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.CheckHealthAnswer":{"result":true,"details":"resou= rce is alive","wait":0}}] } 2015-03-23 18:38:39,739 DEBUG [c.c.a.t.Request] (AgentTaskPool-13:ctx-add211c0) Seq 1-67272519433846841: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { CheckHealthAnswer = } } 2015-03-23 18:38:39,739 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) Details from executing class com.cloud.agent.api.CheckHealthCommand: resource is alive 2015-03-23 18:38:39,739 DEBUG [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) agent (1) responded to = checkHeathCommand, reporting that agent is Up 2015-03-23 18:38:39,739 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) The state determined is Up 2015-03-23 18:38:39,739 INFO [c.c.a.m.AgentManagerImpl] (AgentTaskPool-13:ctx-add211c0) Agent is determined to be up and running 2015-03-23 18:38:39,740 DEBUG [c.c.h.Status] = (AgentTaskPool-13:ctx-add211c0) Transition:[Resource state =3D Enabled, Agent event =3D Ping, Host id = =3D 1, name =3D xs11.cs.com] 2015-03-23 18:38:48,380 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-4f73f279) Zone 1 is ready to launch console proxy 2015-03-23 18:38:48,517 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-cb2ceb59) Zone 1 is ready to launch secondary storage = VM 2015-03-23 18:38:54,543 DEBUG [c.c.s.StatsCollector] (StatsCollector-4:ctx-e5ba0133) AutoScaling Monitor is running... 2015-03-23 18:38:54,579 DEBUG [c.c.s.StatsCollector] (StatsCollector-1:ctx-5c0a66a5) VmStatsCollector is running... 2015-03-23 18:38:55,132 DEBUG [c.c.s.StatsCollector] (StatsCollector-2:ctx-df2bbaf4) HostStatsCollector is running... 2015-03-23 18:38:55,140 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-8:ctx-3a317b3f) Seq 1-67272519433846842: Executing request 2015-03-23 18:38:55,175 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-8:ctx-3a317b3f) Seq 1-67272519433846842: Response Received: 2015-03-23 18:38:55,175 DEBUG [c.c.a.t.Request] (StatsCollector-2:ctx-df2bbaf4) Seq 1-67272519433846842: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer = } } 2015-03-23 18:39:00,042 WARN [c.c.a.m.DirectAgentAttache] (DirectAgentCronJob-9:ctx-2abe5d3c) Unable to get current status on 1(xs11.cs.com) 2015-03-23 18:39:00,776 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-c06a496d) StorageCollector is running... 2015-03-23 18:39:00,780 DEBUG [c.c.s.StatsCollector] (StatsCollector-3:ctx-c06a496d) There is no secondary storage VM for secondary storage host secondary1 2015-03-23 18:39:00,783 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-30:ctx-088657e5) Seq 1-67272519433846843: Executing request 2015-03-23 18:39:01,096 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-30:ctx-088657e5) Seq 1-67272519433846843: Response = Received: 2015-03-23 18:39:01,096 DEBUG [c.c.a.t.Request] (StatsCollector-3:ctx-c06a496d) Seq 1-67272519433846843: Received: { = Ans: , MgmtId: 92378953757938, via: 1, Ver: v1, Flags: 10, { = GetStorageStatsAnswer } } 2015-03-23 18:39:09,560 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-df28f934) Found 0 routers to update status. 2015-03-23 18:39:09,562 DEBUG = [c.c.n.r.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:ctx-df28f934) Found 0 networks to update RvR = status. 2015-03-23 18:39:18,381 DEBUG [c.c.c.ConsoleProxyManagerImpl] (consoleproxy-1:ctx-4a28ff66) Zone 1 is ready to launch console proxy 2015-03-23 18:39:18,517 DEBUG [o.a.c.s.SecondaryStorageManagerImpl] (secstorage-1:ctx-562ec42f) Zone 1 is ready to launch secondary storage = VM