018-01-15 17:01:42,948 DEBUG [o.e.j.s.HttpConnection] (qtp788117692-20:ctx-15545f10) (logid:4f03ff63) releaseRequestBuffer HttpConnection@a9c5d30[p=HttpParser{s=END,251 of 251},g=HttpGenerator@73a06369{s=START}]=>HttpChannelOverHttp@cefd38f{r=1,c=false,a=DISPATCHED,uri=//172.16.25.98:8080/client/api?command=addHost&response=json}<-SocketChannelEndPoint@6e92eae0{/192.168.192.198:51658<->/172.16.25.98:8080,OPEN,fill=-,flush=-,to=24/30000}{io=0/0,kio=0,kro=1}->HttpConnection@a9c5d30[p=HttpParser{s=END,251 of 251},g=HttpGenerator@73a06369{s=START}]=>HttpChannelOverHttp@cefd38f{r=1,c=false,a=DISPATCHED,uri=//172.16.25.98:8080/client/api?command=addHost&response=json} 2018-01-15 17:01:42,948 DEBUG [o.e.j.s.HttpChannelState] (qtp788117692-20:ctx-15545f10) (logid:4f03ff63) onEof HttpChannelState@6f7c92bf{s=DISPATCHED a=NOT_ASYNC i=true r=IDLE w=false} 2018-01-15 17:01:42,948 DEBUG [c.c.a.ApiServlet] (qtp788117692-20:ctx-15545f10) (logid:4f03ff63) ===START=== 192.168.192.198 -- POST command=addHost&response=json 2018-01-15 17:01:42,951 DEBUG [c.c.a.ApiServer] (qtp788117692-20:ctx-15545f10 ctx-175965d8) (logid:4f03ff63) CIDRs from which account 'Acct[f23841f4-fa04-11e7-965b-002590474525-admin]' is allowed to perform API calls: 0.0.0.0/0,::/0 2018-01-15 17:01:42,956 WARN [c.c.a.d.ParamGenericValidationWorker] (qtp788117692-20:ctx-15545f10 ctx-175965d8) (logid:4f03ff63) Received unknown parameters for command addHost. Unknown parameters : clustertype 2018-01-15 17:01:42,957 ERROR [c.c.a.ApiServer] (qtp788117692-20:ctx-15545f10 ctx-175965d8) (logid:4f03ff63) unhandled exception executing api command: [Ljava.lang.String;@6c7bb049 com.cloud.utils.exception.CloudRuntimeException: Guid is not updated for cluster with specified cluster id; need to wait for hosts in this cluster to come up at com.cloud.resource.ResourceManagerImpl.discoverHosts(ResourceManagerImpl.java:592) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:338) at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:197) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:163) at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:92) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:185) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:212) at com.sun.proxy.$Proxy178.discoverHosts(Unknown Source) at org.apache.cloudstack.api.command.admin.host.AddHostCmd.execute(AddHostCmd.java:142) at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:150) at com.cloud.api.ApiServer.queueCommand(ApiServer.java:731) at com.cloud.api.ApiServer.handleRequest(ApiServer.java:555) at com.cloud.api.ApiServlet.processRequestInContext(ApiServlet.java:310) at com.cloud.api.ApiServlet$1.run(ApiServlet.java:130) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53) at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:127) at com.cloud.api.ApiServlet.doPost(ApiServlet.java:94) at javax.servlet.http.HttpServlet.service(HttpServlet.java:706) at javax.servlet.http.HttpServlet.service(HttpServlet.java:791) at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:852) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:535) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143) at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:548) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:190) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1595) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:188) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1253) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:168) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:473) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1564) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:166) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1155) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:527) at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:126) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.Server.handle(Server.java:530) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:347) at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:256) at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:279) at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:102) at org.eclipse.jetty.io.ChannelEndPoint$2.run(ChannelEndPoint.java:124) at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.doProduce(EatWhatYouKill.java:247) at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.produce(EatWhatYouKill.java:140) at org.eclipse.jetty.util.thread.strategy.EatWhatYouKill.run(EatWhatYouKill.java:131) at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:382) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:708) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626) at java.lang.Thread.run(Thread.java:748) 2018-01-15 17:01:42,960 DEBUG [c.c.a.ApiServlet] (qtp788117692-20:ctx-15545f10 ctx-175965d8) (logid:4f03ff63) ===END=== 192.168.192.198 -- POST command=addHost&response=json 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.session] (qtp788117692-20:null) (logid:) FinalSession=org.eclipse.jetty.server.session.Session@3c29a9b2 old_session_manager=null this=org.eclipse.jetty.server.session.SessionHandler455538610==dftMaxIdleSec=1800 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.session] (qtp788117692-20:null) (logid:) Store: id=node0ynvjmn6ctml411bv0249aktjc0, dirty=false, lsave=1516035642729, period=0, elapsed=60231 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.session] (qtp788117692-20:null) (logid:) Non passivating SessionDataStore, session in SessionCache only id=node0ynvjmn6ctml411bv0249aktjc0 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.h.ContextHandler] (qtp788117692-20:null) (logid:) scope null||/client/api @ o.e.j.s.h.MovedContextHandler@44f75083{/,null,AVAILABLE} 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.Server] (qtp788117692-20:null) (logid:) handled=true async=false committed=false on HttpChannelOverHttp@cefd38f{r=1,c=false,a=DISPATCHED,uri=//172.16.25.98:8080/client/api?command=addHost&response=json} 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.HttpChannelState] (qtp788117692-20:null) (logid:) unhandle HttpChannelState@6f7c92bf{s=DISPATCHED a=NOT_ASYNC i=true r=READY w=false} 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.HttpChannel] (qtp788117692-20:null) (logid:) HttpChannelOverHttp@cefd38f{r=1,c=false,a=COMPLETING,uri=//172.16.25.98:8080/client/api?command=addHost&response=json} action COMPLETE 2018-01-15 17:01:42,960 DEBUG [o.e.j.s.h.g.GzipHttpOutputInterceptor] (qtp788117692-20:null) (logid:) org.eclipse.jetty.server.handler.gzip.GzipHttpOutputInterceptor@d12d8a0 exclude by status 530 2018-01-15 17:01:42,961 DEBUG [o.e.j.s.HttpChannel] (qtp788117692-20:null) (logid:) sendResponse info=null content=HeapByteBuffer@60bc7c89[p=0,l=306,c=32768,r=306]={<<<{"addhostresponse...r to come up"}}>>>e":"Enabled","man..."},{"id":"cfe5b} complete=true committing=true callback=Blocker@668c57b9{null} 2018-01-15 17:01:42,961 DEBUG [o.e.j.s.HttpChannel] (qtp788117692-20:null) (logid:) COMMIT for /client/api on HttpChannelOverHttp@cefd38f{r=1,c=true,a=COMPLETING,uri=//172.16.25.98:8080/client/api?command=addHost&response=json} 530 null HTTP/1.1 Content-Type: application/json;charset=utf-8 X-Description: Guid is not updated for cluster with specified cluster id; need to wait for hosts in this cluster to come up X-Content-Type-Options: nosniff X-XSS-Protection: 1;mode=block content-security-policy: 1 content-security-policy: default-src=none content-security-policy: script-src=self content-security-policy: connect-src=self content-security-policy: img-src=self content-security-policy: style-src=self 2018-01-15 17:01:42,961 DEBUG [o.e.j.s.HttpConnection] (qtp788117692-20:null) (logid:) org.eclipse.jetty.server.HttpConnection$SendCallback@21b53bd7[PROCESSING][i=HTTP/1.1{s=530,h=10,cl=-1},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@4bf19f75] generate: NEED_HEADER (null,[p=0,l=306,c=32768,r=306],true)@START 2018-01-15 17:01:42,961 DEBUG [o.e.j.h.HttpGenerator] (qtp788117692-20:null) (logid:) generateHeaders HTTP/1.1{s=530,h=10,cl=-1} last=true content=HeapByteBuffer@60bc7c89[p=0,l=306,c=32768,r=306]={<<<{"addhostresponse...r to come up"}}>>>e":"Enabled","man..."},{"id":"cfe5b} 2018-01-15 17:01:42,961 DEBUG [o.e.j.h.HttpGenerator] (qtp788117692-20:null) (logid:) Content-Type: application/json;charset=utf-8 X-Description: Guid is not updated for cluster with specified cluster id; need to wait for hosts in this cluster to come up X-Content-Type-Options: nosniff X-XSS-Protection: 1;mode=block content-security-policy: 1 content-security-policy: default-src=none content-security-policy: script-src=self content-security-policy: connect-src=self content-security-policy: img-src=self content-security-policy: style-src=self 2018-01-15 17:01:42,961 DEBUG [o.e.j.h.HttpGenerator] (qtp788117692-20:null) (logid:) CONTENT_LENGTH 2018-01-15 17:01:42,961 DEBUG [o.e.j.s.HttpConnection] (qtp788117692-20:null) (logid:) org.eclipse.jetty.server.HttpConnection$SendCallback@21b53bd7[PROCESSING][i=HTTP/1.1{s=530,h=10,cl=-1},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@4bf19f75] generate: FLUSH ([p=0,l=513,c=8192,r=513],[p=0,l=306,c=32768,r=306],true)@COMPLETING