Return-Path: X-Original-To: apmail-incubator-cloudstack-users-archive@minotaur.apache.org Delivered-To: apmail-incubator-cloudstack-users-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id A3ECD927D for ; Mon, 4 Mar 2013 16:09:07 +0000 (UTC) Received: (qmail 84955 invoked by uid 500); 4 Mar 2013 16:09:07 -0000 Delivered-To: apmail-incubator-cloudstack-users-archive@incubator.apache.org Received: (qmail 84924 invoked by uid 500); 4 Mar 2013 16:09:07 -0000 Mailing-List: contact cloudstack-users-help@incubator.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: cloudstack-users@incubator.apache.org Delivered-To: mailing list cloudstack-users@incubator.apache.org Received: (qmail 84915 invoked by uid 99); 4 Mar 2013 16:09:07 -0000 Received: from nike.apache.org (HELO nike.apache.org) (192.87.106.230) by apache.org (qpsmtpd/0.29) with ESMTP; Mon, 04 Mar 2013 16:09:07 +0000 X-ASF-Spam-Status: No, hits=-0.0 required=5.0 tests=SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (nike.apache.org: local policy) Received: from [93.95.13.47] (HELO engine01-20263-1.icritical.com) (93.95.13.47) by apache.org (qpsmtpd/0.29) with SMTP; Mon, 04 Mar 2013 16:08:58 +0000 Received: (qmail 23439 invoked from network); 4 Mar 2013 16:08:36 -0000 Received: from localhost (127.0.0.1) by engine01-20263-1.icritical.com with SMTP; 4 Mar 2013 16:08:36 -0000 Received: from engine01-20263-1.icritical.com ([127.0.0.1]) by localhost (engine01-20263-1.icritical.com [127.0.0.1]) (amavisd-new, port 10024) with SMTP id 22042-09 for ; Mon, 4 Mar 2013 16:08:29 +0000 (GMT) Received: (qmail 23428 invoked by uid 599); 4 Mar 2013 16:08:29 -0000 Received: from unknown (HELO mail.sys-pro.co.uk) (188.227.188.80) by engine01-20263-1.icritical.com (qpsmtpd/0.28) with ESMTP; Mon, 04 Mar 2013 16:08:29 +0000 Received: from SPCI2-EXCHANGE.sys-pro.local ([fe80::e17d:e181:ef61:3d93]) by SPCI2-EXCHANGE.sys-pro.local ([fe80::e17d:e181:ef61:3d93%11]) with mapi id 14.02.0342.003; Mon, 4 Mar 2013 16:08:29 +0000 From: Nick Fisk To: "'cloudstack-users@incubator.apache.org'" <'cloudstack-users@incubator.apache.org'> Subject: Adding KVM host Ubuntu 12.04 Thread-Topic: Adding KVM host Ubuntu 12.04 Thread-Index: Ac4Y8nbOVKkFBUazSBCUSeoNG/I/Vw== Date: Mon, 4 Mar 2013 16:08:28 +0000 Message-ID: Accept-Language: en-US, en-GB Content-Language: en-US X-MS-Has-Attach: X-MS-TNEF-Correlator: x-originating-ip: [10.2.0.88] Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: quoted-printable MIME-Version: 1.0 X-Virus-Scanned: by iCritical at engine01-20263-1.icritical.com X-Virus-Checked: Checked by ClamAV on apache.org Hi, I am trying to create a very simple test Cloudstack install to learn more a= bout Cloudstack. I have followed the install guide and created 2 hosts runn= ing Ubuntu 12.04. I have got the management node working easily and have no= problems until I try and add the second host also running Ubuntu 12.04 and= KVM. I cannot the life of me figure out why it is not adding the host and = from what I can see in the logs apart from the management server eventually= timing out I can't see any obvious problems. Under the assumption that the cloud-agent contacts the management server to= register itself on port 8250 I have tried a telnet from agent to MS, which= gets through, so I believe networking wise everything should be ok. I would be very grateful for any help that anyone can give as I have really= exhausted all other options. I have included the logs below. Many Thanks, Nick Management.log 2013-03-04 15:40:07,819 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null)= =3D=3D=3DSTART=3D=3D=3D 10.2.0.88 -- GET command=3DlistZones&response=3D= json&sessionkey=3D%2BWRFnmWSjm6Gx51KopGq%2B9Smne8%3D&listAll=3Dtrue&_=3D136= 2411607463 2013-03-04 15:40:07,831 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null)= =3D=3D=3DEND=3D=3D=3D 10.2.0.88 -- GET command=3DlistZones&response=3Djs= on&sessionkey=3D%2BWRFnmWSjm6Gx51KopGq%2B9Smne8%3D&listAll=3Dtrue&_=3D13624= 11607463 2013-03-04 15:40:07,891 DEBUG [cloud.api.ApiServlet] (catalina-exec-22:null= ) =3D=3D=3DSTART=3D=3D=3D 10.2.0.88 -- GET command=3DlistPods&zoneid=3D77= 24711a-ac04-4593-9262-815af8f69273&response=3Djson&sessionkey=3D%2BWRFnmWSj= m6Gx51KopGq%2B9Smne8%3D&_=3D1362411607540 2013-03-04 15:40:07,912 DEBUG [cloud.api.ApiServlet] (catalina-exec-22:null= ) =3D=3D=3DEND=3D=3D=3D 10.2.0.88 -- GET command=3DlistPods&zoneid=3D7724= 711a-ac04-4593-9262-815af8f69273&response=3Djson&sessionkey=3D%2BWRFnmWSjm6= Gx51KopGq%2B9Smne8%3D&_=3D1362411607540 2013-03-04 15:40:07,959 DEBUG [cloud.api.ApiServlet] (catalina-exec-14:null= ) =3D=3D=3DSTART=3D=3D=3D 10.2.0.88 -- GET command=3DlistClusters&podid= =3D4431bb6a-7817-4b94-8175-3dc8ed482687&response=3Djson&sessionkey=3D%2BWRF= nmWSjm6Gx51KopGq%2B9Smne8%3D&_=3D1362411607609 2013-03-04 15:40:07,980 DEBUG [cloud.api.ApiServlet] (catalina-exec-14:null= ) =3D=3D=3DEND=3D=3D=3D 10.2.0.88 -- GET command=3DlistClusters&podid=3D4= 431bb6a-7817-4b94-8175-3dc8ed482687&response=3Djson&sessionkey=3D%2BWRFnmWS= jm6Gx51KopGq%2B9Smne8%3D&_=3D1362411607609 2013-03-04 15:40:16,164 DEBUG [cloud.api.ApiServlet] (catalina-exec-7:null)= =3D=3D=3DSTART=3D=3D=3D 10.2.0.88 -- GET command=3DaddHost&zoneid=3D7724= 711a-ac04-4593-9262-815af8f69273&podid=3D4431bb6a-7817-4b94-8175-3dc8ed4826= 87&clusterid=3D1abf0ec1-bcff-4985-ba19-40330862082b&hypervisor=3DKVM&cluste= rtype=3DCloudManaged&hosttags=3Dtest&username=3Droot&url=3Dhttp%3A%2F%2Fclo= udhost&response=3Djson&sessionkey=3D%2BWRFnmWSjm6Gx51KopGq%2B9Smne8%3D&_=3D= 1362411615809 2013-03-04 15:40:16,189 INFO [cloud.resource.ResourceManagerImpl] (catalin= a-exec-7:null) Trying to add a new host at http://cloudhost in data center = 1 2013-03-04 15:40:16,402 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-7:nul= l) Executing cmd: lsmod|grep kvm 2013-03-04 15:40:17,721 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-7:nul= l) lsmod|grep kvm output:kvm_intel 137721 0 kvm 415459 1 kvm_intel 2013-03-04 15:40:18,733 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-7:nul= l) Executing cmd: cloud-setup-agent -m 10.2.0.100 -z 1 -p 1 -c 1 -g 2fe97c= a3-ce8b-3980-a465-5e4081234083 -a --pubNic=3Dcloudbr0 --prvNic=3Dcloudbr0 -= -guestNic=3Dcloudbr0 2013-03-04 15:40:22,354 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:40:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:40:36,609 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) VmStatsCollector is running... 2013-03-04 15:40:36,625 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) HostStatsCollector is running... 2013-03-04 15:40:36,785 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) StorageCollector is running... 2013-03-04 15:40:51,628 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-7:nul= l) cloud-setup-agent -m 10.2.0.100 -z 1 -p 1 -c 1 -g 2fe97ca3-ce8b-3980-a4= 65-5e4081234083 -a --pubNic=3Dcloudbr0 --prvNic=3Dcloudbr0 --guestNic=3Dclo= udbr0 output:CloudStack Agent setup is done! [OK] Configure cloudAgent ... 2013-03-04 15:40:52,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:40:53,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:41:22,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:41:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:41:36,613 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) VmStatsCollector is running... 2013-03-04 15:41:36,629 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) HostStatsCollector is running... 2013-03-04 15:41:36,790 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) StorageCollector is running... 2013-03-04 15:41:52,355 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:41:53,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:42:22,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:42:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:42:36,617 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) VmStatsCollector is running... 2013-03-04 15:42:36,633 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) HostStatsCollector is running... 2013-03-04 15:42:36,796 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) StorageCollector is running... 2013-03-04 15:42:52,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:42:53,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:43:22,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:43:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:43:36,622 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) VmStatsCollector is running... 2013-03-04 15:43:36,637 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) HostStatsCollector is running... 2013-03-04 15:43:36,801 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) StorageCollector is running... 2013-03-04 15:43:52,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:43:53,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:44:22,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:44:23,327 DEBUG [storage.snapshot.SnapshotSchedulerImpl] (Sna= pshotPollTask:null) Snapshot scheduler.poll is being called at 2013-03-04 1= 5:44:23 GMT 2013-03-04 15:44:23,331 DEBUG [storage.snapshot.SnapshotSchedulerImpl] (Sna= pshotPollTask:null) Got 0 snapshots to be executed at 2013-03-04 15:44:23 G= MT 2013-03-04 15:44:23,473 DEBUG [cloud.network.ExternalLoadBalancerUsageManag= erImpl] (ExternalNetworkMonitor-1:null) External load balancer devices stat= s collector is running... 2013-03-04 15:44:23,544 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterMonitor-1:null) Found 0 running routers. 2013-03-04 15:44:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:44:36,626 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) VmStatsCollector is running... 2013-03-04 15:44:36,641 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) HostStatsCollector is running... 2013-03-04 15:44:36,807 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) StorageCollector is running... 2013-03-04 15:44:42,445 DEBUG [cloud.cluster.ClusterManagerImpl] (Cluster-H= eartbeat-1:null) Management server heartbeat takes too long to finish. prof= iler: Done. Duration: 4392ms, profilerHeartbeatUpdate: Done. Duration: 4386= ms, profilerPeerScan: Done. Duration: 6ms, profilerAgentLB: Done. Duration:= 0ms 2013-03-04 15:44:52,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:44:53,282 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Running Capacity Checker ... 2013-03-04 15:44:53,282 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) recalculating system capacity 2013-03-04 15:44:53,283 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Executing cpu/ram capacity update 2013-03-04 15:44:53,286 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done executing cpu/ram capacity update 2013-03-04 15:44:53,287 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Executing storage capacity update 2013-03-04 15:44:53,289 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done executing storage capacity update 2013-03-04 15:44:53,289 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Executing capacity updates for public ip and Vlans 2013-03-04 15:44:53,300 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done capacity updates for public ip and Vlans 2013-03-04 15:44:53,300 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Executing capacity updates for private ip 2013-03-04 15:44:53,307 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done executing capacity updates for private ip 2013-03-04 15:44:53,307 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done recalculating system capacity 2013-03-04 15:44:53,326 DEBUG [cloud.alert.AlertManagerImpl] (CapacityCheck= er:null) Done running Capacity Checker ... 2013-03-04 15:44:53,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:45:22,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:45:23,574 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. 2013-03-04 15:45:36,630 DEBUG [cloud.server.StatsCollector] (StatsCollector= -1:null) VmStatsCollector is running... 2013-03-04 15:45:36,646 DEBUG [cloud.server.StatsCollector] (StatsCollector= -2:null) HostStatsCollector is running... 2013-03-04 15:45:36,813 DEBUG [cloud.server.StatsCollector] (StatsCollector= -3:null) StorageCollector is running... 2013-03-04 15:45:52,352 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] = (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage= UPintenance mode 2013-03-04 15:45:52,665 DEBUG [kvm.discoverer.KvmServerDiscoverer] (catalin= a-exec-7:null) Timeout, to wait for the host connecting to mgt svr, assumin= g it is failed 2013-03-04 15:45:52,677 WARN [cloud.resource.ResourceManagerImpl] (catalin= a-exec-7:null) Unable to find the server resources at http://cloudhost 2013-03-04 15:45:52,679 WARN [api.commands.AddHostCmd] (catalina-exec-7:nu= ll) Exception: com.cloud.exception.DiscoveryException: Unable to add the host at com.cloud.resource.ResourceManagerImpl.discoverHostsFull(Resourc= eManagerImpl.java:737) at com.cloud.resource.ResourceManagerImpl.discoverHosts(ResourceMan= agerImpl.java:544) at com.cloud.api.commands.AddHostCmd.execute(AddHostCmd.java:140) at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:138) at com.cloud.api.ApiServer.queueCommand(ApiServer.java:544) at com.cloud.api.ApiServer.handleRequest(ApiServer.java:423) at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:312) at com.cloud.api.ApiServlet.doGet(ApiServlet.java:64) at javax.servlet.http.HttpServlet.service(HttpServlet.java:617) at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter= (ApplicationFilterChain.java:290) at org.apache.catalina.core.ApplicationFilterChain.doFilter(Applica= tionFilterChain.java:206) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWra= pperValve.java:233) at org.apache.catalina.core.StandardContextValve.invoke(StandardCon= textValve.java:191) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostVa= lve.java:127) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportVa= lve.java:102) at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.= java:615) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngi= neValve.java:109) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapte= r.java:293) at org.apache.coyote.http11.Http11NioProcessor.process(Http11NioPro= cessor.java:889) at org.apache.coyote.http11.Http11NioProtocol$Http11ConnectionHandl= er.process(Http11NioProtocol.java:744) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEn= dpoint.java:2282) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExec= utor.java:1146) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExe= cutor.java:615) at java.lang.Thread.run(Thread.java:679) 2013-03-04 15:45:52,684 WARN [cloud.api.ApiDispatcher] (catalina-exec-7:nu= ll) class com.cloud.api.ServerApiException : Unable to add the host 2013-03-04 15:45:52,686 DEBUG [cloud.api.ApiServlet] (catalina-exec-7:null)= =3D=3D=3DEND=3D=3D=3D 10.2.0.88 -- GET command=3DaddHost&zoneid=3D772471= 1a-ac04-4593-9262-815af8f69273&podid=3D4431bb6a-7817-4b94-8175-3dc8ed482687= &clusterid=3D1abf0ec1-bcff-4985-ba19-40330862082b&hypervisor=3DKVM&clustert= ype=3DCloudManaged&hosttags=3Dtest&username=3Droot&url=3Dhttp%3A%2F%2Fcloud= host&response=3Djson&sessionkey=3D%2BWRFnmWSjm6Gx51KopGq%2B9Smne8%3D&_=3D13= 62411615809 2013-03-04 15:45:53,575 DEBUG [network.router.VirtualNetworkApplianceManage= rImpl] (RouterStatusMonitor-1:null) Found 0 routers. Agent.log 2013-03-04 15:40:50,868 INFO [utils.component.ComponentLocator] (main:null= ) Unable to find components.xml 2013-03-04 15:40:50,869 INFO [utils.component.ComponentLocator] (main:null= ) Skipping configuration using components.xml 2013-03-04 15:40:50,869 INFO [cloud.agent.AgentShell] (main:null) Implemen= tation Version is 4.0.1-incubating.20130204235713 2013-03-04 15:40:50,870 INFO [cloud.agent.AgentShell] (main:null) agent.pr= operties found at /etc/cloud/agent/agent.properties 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: guest.network.device 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: private.network.device 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: port 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: resource 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: pod 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: zone 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: guid 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: cluster 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: public.network.device 2013-03-04 15:40:50,871 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: local.storage.uuid 2013-03-04 15:40:50,872 DEBUG [cloud.agent.AgentShell] (main:null) Found pr= operty: host 2013-03-04 15:40:50,872 INFO [cloud.agent.AgentShell] (main:null) Defaulti= ng to using properties file for storage 2013-03-04 15:40:50,874 INFO [cloud.agent.AgentShell] (main:null) Defaulti= ng to the constant time backoff algorithm 2013-03-04 15:40:50,874 DEBUG [cloud.agent.AgentShell] (main:null) Checking= to see if agent.pid exists. 2013-03-04 15:40:50,883 DEBUG [cloud.utils.ProcessUtil] (main:null) Executi= ng: bash -c echo $PPID 2013-03-04 15:40:50,890 DEBUG [cloud.utils.ProcessUtil] (main:null) Executi= on is successful. 2013-03-04 15:40:50,954 INFO [cloud.agent.Agent] (main:null) id is 2013-03-04 15:40:50,955 DEBUG [cloud.resource.ServerResourceBase] (main:nul= l) Retrieving network interface: cloudbr0 2013-03-04 15:40:50,958 DEBUG [cloud.resource.ServerResourceBase] (main:nul= l) Retrieving network interface: cloudbr0 2013-03-04 15:40:50,958 DEBUG [cloud.resource.ServerResourceBase] (main:nul= l) Retrieving network interface: null 2013-03-04 15:40:50,958 DEBUG [cloud.resource.ServerResourceBase] (main:nul= l) Retrieving network interface: null 2013-03-04 15:40:51,047 INFO [resource.virtualnetwork.VirtualRoutingResour= ce] (main:null) VirtualRoutingResource _scriptDir to use: scripts/network/d= omr/kvm 2013-03-04 15:40:51,047 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in the classpath 2013-03-04 15:40:51,048 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,048 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh 2013-03-04 15:40:51,048 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,048 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/java/scripts/network/domr/kvm/call_firewall= .sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/java/scripts/network/domr/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/java/scripts/network/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/java/scripts/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/java/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/share/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /call_firewall.sh 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,049 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/call_fi= rewall.sh 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_firewall.sh in /usr/lib/cloud/common/scripts/network/domr/call_firewa= ll.sh 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in the classpath 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/java/scripts/network/domr/kvm/call_load= balancer.sh 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/java/scripts/network/domr/call_loadbala= ncer.sh 2013-03-04 15:40:51,050 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/java/scripts/network/call_loadbalancer.= sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/java/scripts/call_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/java/call_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/share/call_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/call_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /call_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/cal= l_loadbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= call_loadbalancer.sh in /usr/lib/cloud/common/scripts/network/domr/call_lo= adbalancer.sh 2013-03-04 15:40:51,051 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in the classpath 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/java/scripts/network/domr/kvm/save_= password_to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/java/scripts/network/domr/save_pass= word_to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/java/scripts/network/save_password_= to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/java/scripts/save_password_to_domr.= sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/java/save_password_to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/share/save_password_to_domr.sh 2013-03-04 15:40:51,052 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/save_password_to_domr.sh 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /save_password_to_domr.sh 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/lib/cloud/common/scripts/network/domr/kvm= /save_password_to_domr.sh 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Looking for= save_password_to_domr.sh in /usr/lib/cloud/common/scripts/network/domr/sav= e_password_to_domr.sh 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in the classpath 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,053 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/java/scripts/network/domr/kvm/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/java/scripts/network/domr/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/java/scripts/network/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/java/scripts/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/java/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/share/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /dhcp_entry.sh 2013-03-04 15:40:51,054 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/dhcp_entry= .sh 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= dhcp_entry.sh in /usr/lib/cloud/common/scripts/network/domr/dhcp_entry.sh 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in the classpath 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/java/scripts/network/domr/kvm/vm_data.sh 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/java/scripts/network/domr/vm_data.sh 2013-03-04 15:40:51,055 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/java/scripts/network/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/java/scripts/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/java/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/share/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/vm_data.sh 2013-03-04 15:40:51,056 DEBUG [utils.script.Script] (main:null) Looking for= vm_data.sh in /usr/lib/cloud/common/scripts/network/domr/vm_data.sh 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in the classpath 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/java/scripts/network/domr/kvm/bumpUpPriori= ty.sh 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/java/scripts/network/domr/bumpUpPriority.s= h 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/java/scripts/network/bumpUpPriority.sh 2013-03-04 15:40:51,057 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/java/scripts/bumpUpPriority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/java/bumpUpPriority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/share/bumpUpPriority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/bumpUpPriority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /bumpUpPriority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/bumpUp= Priority.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= bumpUpPriority.sh in /usr/lib/cloud/common/scripts/network/domr/bumpUpPrio= rity.sh 2013-03-04 15:40:51,058 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in the classpath 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/network/domr/kvm/router_proxy.s= h 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/network/domr/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/network/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/router_proxy.sh 2013-03-04 15:40:51,059 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /router_proxy.sh 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/lib/cloud/common/scripts/network/domr/kvm/router_p= roxy.sh 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/lib/cloud/common/scripts/network/domr/router_proxy= .sh 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in the classpath 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh 2013-03-04 15:40:51,060 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,061 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/java/scripts/vm/network/vnet/modifyvlan.sh 2013-03-04 15:40:51,061 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/java/scripts/vm/network/modifyvlan.sh 2013-03-04 15:40:51,065 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/java/scripts/vm/modifyvlan.sh 2013-03-04 15:40:51,065 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/java/scripts/modifyvlan.sh 2013-03-04 15:40:51,065 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/java/modifyvlan.sh 2013-03-04 15:40:51,065 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/share/modifyvlan.sh 2013-03-04 15:40:51,065 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/modifyvlan.sh 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /modifyvlan.sh 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) Looking for= modifyvlan.sh in /usr/lib/cloud/common/scripts/vm/network/vnet/modifyvlan.= sh 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in the classpath 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,066 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/java/scripts/vm/hypervisor/kvm/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/java/scripts/vm/hypervisor/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/java/scripts/vm/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/java/scripts/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/java/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/share/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /versions.sh 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,067 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/kvm/versions.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= versions.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/versions.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in the classpath 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/scripts/vm/hypervisor/kvm/patch/rundomrpr= e.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/scripts/vm/hypervisor/kvm/rundomrpre.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/scripts/vm/hypervisor/rundomrpre.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/scripts/vm/rundomrpre.sh 2013-03-04 15:40:51,068 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/scripts/rundomrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/java/rundomrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/share/rundomrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/rundomrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /rundomrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/kvm/patch/run= domrpre.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= rundomrpre.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/kvm/rundomrpr= e.sh 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in the classpath 2013-03-04 15:40:51,069 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/java/scripts/vm/hypervisor/kvm/kvmheartbeat.= sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/java/scripts/vm/hypervisor/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/java/scripts/vm/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/java/scripts/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/java/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/share/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /kvmheartbeat.sh 2013-03-04 15:40:51,070 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Looking for= kvmheartbeat.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/kvm/kvmhear= tbeat.sh 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in the classpath 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/share/java/scripts/storage/qcow2/createvm.sh 2013-03-04 15:40:51,071 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/share/java/scripts/storage/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/share/java/scripts/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/share/java/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/share/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= createvm.sh in /usr/lib/cloud/common/scripts/storage/qcow2/createvm.sh 2013-03-04 15:40:51,072 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in the classpath 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/share/java/scripts/storage/qcow2/managesnapshot.= sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/share/java/scripts/storage/managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/share/java/scripts/managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/share/java/managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/share/managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /managesnapshot.sh 2013-03-04 15:40:51,073 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= managesnapshot.sh in /usr/lib/cloud/common/scripts/storage/qcow2/managesna= pshot.sh 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in the classpath 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/share/java/scripts/storage/qcow2/createtmplt.sh 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/share/java/scripts/storage/createtmplt.sh 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/share/java/scripts/createtmplt.sh 2013-03-04 15:40:51,074 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/share/java/createtmplt.sh 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/share/createtmplt.sh 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/createtmplt.sh 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /createtmplt.sh 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= createtmplt.sh in /usr/lib/cloud/common/scripts/storage/qcow2/createtmplt.= sh 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in the classpath 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,075 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/java/scripts/vm/network/vnet/security_grou= p.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/java/scripts/vm/network/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/java/scripts/vm/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/java/scripts/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/java/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/share/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /security_group.py 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,076 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/lib/cloud/common/scripts/vm/network/vnet/securit= y_group.py 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= security_group.py in /usr/lib/cloud/common/scripts/vm/network/security_gro= up.py 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in the classpath 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/network/domr/router_proxy.sh 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/network/router_proxy.sh 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/scripts/router_proxy.sh 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/java/router_proxy.sh 2013-03-04 15:40:51,077 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/share/router_proxy.sh 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/router_proxy.sh 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /router_proxy.sh 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Looking for= router_proxy.sh in /usr/lib/cloud/common/scripts/network/domr/router_proxy= .sh 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in the classpath 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) System reso= urce: null 2013-03-04 15:40:51,078 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Current bin= aries reside at /usr/share/java 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/java/scripts/vm/hypervisor/kvm/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/java/scripts/vm/hypervisor/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/java/scripts/vm/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/java/scripts/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/java/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/share/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /pingtest.sh 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) Searching i= n environment.properties 2013-03-04 15:40:51,079 DEBUG [utils.script.Script] (main:null) environment= .properties says scripts should be in /usr/lib/cloud/common 2013-03-04 15:40:51,080 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/kvm/pingtest.sh 2013-03-04 15:40:51,080 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/lib/cloud/common/scripts/vm/hypervisor/pingtest.sh 2013-03-04 15:40:51,080 DEBUG [utils.script.Script] (main:null) Looking for= pingtest.sh in /usr/lib/cloud/common/scripts/vm/pingtest.sh Nick Fisk Technical Support Engineer System Professional Ltd tel: 01825 830000 mob: 07711377522 fax: 01825 830001 mail: Nick.Fisk@sys-pro.co.uk web: www.sys-pro.co.uk IT SUPPORT SERVICES | VIRTUALISATION | STORAGE | BACKUP AND DR | IT CONSULT= ING Registered Office: Wilderness Barns, Wilderness Lane, Hadlow Down, East Sussex, TN22 4HU Registered in England and Wales. Company Number: 04754200 Confidentiality: This e-mail and its attachments are intended for the above= named only and may be confidential. If they have come to you in error you = must take no action based on them, nor must you copy or show them to anyone= ; please reply to this e-mail and highlight the error. Security Warning: Please note that this e-mail has been created in the know= ledge that Internet e-mail is not a 100% secure communications medium. We a= dvise that you understand and observe this lack of security when e-mailing = us. Viruses: Although we have taken steps to ensure that this e-mail and attach= ments are free from any virus, we advise that in keeping with good computin= g practice the recipient should ensure they are actually virus free. Any vi= ews expressed in this e-mail message are those of the individual and not ne= cessarily those of the company or any of its subsidiaries.