cloudstack-users mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Rafael Weingärtner <rafaelweingart...@gmail.com>
Subject Re: Unable to start SSVM
Date Wed, 02 Aug 2017 14:24:56 GMT
Great; if you need any help do not hesitate to reach us here.

On Wed, Aug 2, 2017 at 11:20 AM, Rodrigo Baldasso <rodrigo@loophost.com.br>
wrote:

> Yes, it is. I'll try to find out the main reason for that happen and if
> find a way to fix the code, share here.
>
> Thanks.
>
> - - - - - - - - - - - - - - - - - - -
>
> Rodrigo Baldasso - LHOST
>
> (51) 9 8419-9861
> - - - - - - - - - - - - - - - - - - -
> On 02/08/2017 11:16:47, Rafael Weingärtner <rafaelweingartner@gmail.com>
> wrote:
> Ah, that is what I wanted to check now ...
> I was going to ask you to execute the following SQL:
> select v.* from pod_vlan_map vlanMap
> join vlan v on v.id = vlanMap.vlan_db_id
> where v.removed is null and vlanMap.pod_id = 1
>
> So, now everything is ok for you?
>
> On Wed, Aug 2, 2017 at 11:13 AM, Rodrigo Baldasso
> wrote:
>
> > Confirmed: when the pod has more than one vlan on the vlan table, it
> > throws this exception error. I've deleted all vlans leaving only the one
> > with ID 14 (that i created for this test) and was able to sucessfully
> > delete the pod.
> >
> > Maybe the code doesn't handle more than one match of pod vlans, and
> > then show the nullpointer error.
> >
> > - - - - - - - - - - - - - - - - - - -
> >
> > Rodrigo Baldasso - LHOST
> >
> > (51) 9 8419-9861
> > - - - - - - - - - - - - - - - - - - -
> > On 02/08/2017 11:09:53, Rodrigo Baldasso wrote:
> > ID of problematic pod: 1
> >
> > 4 is the ID of the working pod. However all settings between them are
> > identical. The problem seems to be when one pod has *more* than one vlan
> > (deleted or not).
> >
> > - - - - - - - - - - - - - - - - - - -
> >
> > Rodrigo Baldasso - LHOST
> >
> > (51) 9 8419-9861
> > - - - - - - - - - - - - - - - - - - -
> > On 02/08/2017 11:08:32, Rafael Weingärtner
> > wrote:
> > What is the ID of the pod you want to remove? 1 or 4?
> >
> > On Wed, Aug 2, 2017 at 11:03 AM, Rodrigo Baldasso
> > wrote:
> >
> > > Yep: http://prntscr.com/g3gab3
> > >
> > > - - - - - - - - - - - - - - - - - - -
> > >
> > > Rodrigo Baldasso - LHOST
> > >
> > > (51) 9 8419-9861
> > > - - - - - - - - - - - - - - - - - - -
> > > On 02/08/2017 11:02:40, Rafael Weingärtner
> > > wrote:
> > > I mean, I said 14 because this was the one select by you. Can you check
> > the
> > > VLAN table searching by ID (vlan_db_id) from VLAN map table of the pod
> > that
> > > you are having problems to remove.
> > >
> > > On Wed, Aug 2, 2017 at 11:00 AM, Rafael Weingärtner
> > > rafaelweingartner@gmail.com> wrote:
> > >
> > > > Interesting; now, can you try to find a vlan with ID=14 in "vlan"
> > table?
> > > >
> > > > On Wed, Aug 2, 2017 at 10:58 AM, Rodrigo Baldasso
> > > > > wrote:
> > > >
> > > >> Sure: http://prntscr.com/g3g7iu
> > > >>
> > > >> The last vlan map is the one that I created for testing on the
> > > >> problematic pod.
> > > >>
> > > >> - - - - - - - - - - - - - - - - - - -
> > > >>
> > > >> Rodrigo Baldasso - LHOST
> > > >>
> > > >> (51) 9 8419-9861
> > > >> - - - - - - - - - - - - - - - - - - -
> > > >> On 02/08/2017 10:56:01, Rafael Weingärtner
> > > >> wrote:
> > > >> Can you also list the table "pod_vlan_map" for all of the "maps" of
> > > vlans
> > > >> for the given POD?
> > > >>
> > > >> On Wed, Aug 2, 2017 at 10:40 AM, Rodrigo Baldasso
> > > >> wrote:
> > > >>
> > > >> > I've created a new vlan/ip pool just for this test (had already
> > > removed
> > > >> > all ip pool before), the problem persisted.
> > > >> >
> > > >> > here is how the new vlan looks like in my db:
> > > >> >
> > > >> > http://prntscr.com/g3fxt1
> > > >> >
> > > >> > It's pretty equals to the one of the working pod.
> > > >> >
> > > >> >
> > > >> >
> > > >> > - - - - - - - - - - - - - - - - - - -
> > > >> >
> > > >> > Rodrigo Baldasso - LHOST
> > > >> >
> > > >> > (51) 9 8419-9861
> > > >> > - - - - - - - - - - - - - - - - - - -
> > > >> > On 02/08/2017 10:21:47, Rafael Weingärtner
> > > >> > wrote:
> > > >> > Ok,
> > > >> >
> > > >> > Following the code where the null pointer happens at line 163:
> > > >> > https://github.com/apache/cloudstack/blob/0e057ad69edab9f166
> > > >> 4924ac1fb250
> > > >> > 0ca799cfb6/engine/schema/src/com/cloud/dc/dao/VlanDaoImpl.java
> > > >> >
> > > >> > can you list all VLANs in "vlan" table that have the PODid equals
> > one
> > > of
> > > >> > the Pods you want to remove?Also, please filter the already
> removed
> > > >> VLANs.
> > > >> >
> > > >> > On Wed, Aug 2, 2017 at 9:26 AM, Rodrigo Baldasso
> > > >> > wrote:
> > > >> >
> > > >> > > This pod got somewhat corrupted when I change it's IP pool
> > > allocation
> > > >> > > cidr. After changing, it didn't started the SSVM's with the
> > > >> nullpointer
> > > >> > > error that i've send before and now the pod can't be deleted,
> also
> > > >> > throwing
> > > >> > > the nullpointer error.
> > > >> > >
> > > >> > > Thanks.
> > > >> > >
> > > >> > > - - - - - - - - - - - - - - - - - - -
> > > >> > >
> > > >> > > Rodrigo Baldasso - LHOST
> > > >> > >
> > > >> > > (51) 9 8419-9861
> > > >> > > - - - - - - - - - - - - - - - - - - -
> > > >> > > On 02/08/2017 09:24:36, Rafael Weingärtner
> > > >> > > wrote:
> > > >> > > Well, looking at the data you posted, the problem should not
> > happen.
> > > >> > Let´s
> > > >> > > take step back. Can you describe briefly what you are trying to
> > do,
> > > >> and
> > > >> > > what problem you are having now?
> > > >> > >
> > > >> > > On Wed, Aug 2, 2017 at 9:17 AM, Rodrigo Baldasso
> > > >> > > wrote:
> > > >> > >
> > > >> > > > Hi Rafael,
> > > >> > > >
> > > >> > > > I checked this table yesterday and couldn't find nothing
> > wrong.. i
> > > >> > made a
> > > >> > > > line around the vLan of the new pod (that is working). The
> other
> > > >> vLans
> > > >> > > are
> > > >> > > > from the pod that i'm unable to delete and didn't booted the
> > > SSVM's.
> > > >> > They
> > > >> > > > have the column 'removed' with the date that i deleted them.
> > > >> > > >
> > > >> > > > http://prntscr.com/g3eqpr
> > > >> > > >
> > > >> > > > - - - - - - - - - - - - - - - - - - -
> > > >> > > >
> > > >> > > > Rodrigo Baldasso - LHOST
> > > >> > > >
> > > >> > > > (51) 9 8419-9861
> > > >> > > > - - - - - - - - - - - - - - - - - - -
> > > >> > > > On 02/08/2017 09:12:36, Rafael Weingärtner
> > > >> > > > wrote:
> > > >> > > > Rodrigo,
> > > >> > > >
> > > >> > > > There is an inconsistency in your database.
> > > >> > > >
> > > >> > > > To get this null pointer, the column "vlan_type" of table
> "vlan"
> > > >> must
> > > >> > be
> > > >> > > > null or something unrecognized in the database. Can you check
> > this
> > > >> > table?
> > > >> > > >
> > > >> > > > On Tue, Aug 1, 2017 at 1:03 PM, Rodrigo Baldasso
> > > >> > > > wrote:
> > > >> > > >
> > > >> > > > > Thank you.
> > > >> > > > >
> > > >> > > > > This is the log when I try to delete this pod, if it helps.
> > > >> > > > >
> > > >> > > > > 2017-08-01 13:03:01,361 DEBUG [c.c.a.ApiServlet]
> > > >> > > > > (catalina-exec-9:ctx-262022ac) (logid:91c02e8f) ===START===
> > > >> > > 186.250.14.20
> > > >> > > > > -- GET command=deletePod&id=39e23530-0553-4b54-948d-
> > > >> > > > > 5da00c4952c2&response=json&_=1501603382823
> > > >> > > > > 2017-08-01 13:03:01,556 DEBUG [c.c.u.d.T.Transaction]
> > > >> > > > > (catalina-exec-9:ctx-262022ac ctx-77de8cad) (logid:91c02e8f)
> > > >> Rolling
> > > >> > > back
> > > >> > > > > the transaction: Time = 179 Name = catalina-exec-9; called
> by
> > > >> > > > > -TransactionLegacy.rollback:889-TransactionLegacy.
> > > removeUpTo:832-
> > > >> > > > > TransactionLegacy.close:656-Transaction.execute:43-
> > > >> > > > Transaction.execute:47-
> > > >> > > > > ConfigurationManagerImpl.deletePod:1009-
> > > NativeMethodAccessorImpl.
> > > >> > > > > invoke0:-2-NativeMethodAccessorImpl.invoke:57-
> > > >> > > > > DelegatingMethodAccessorImpl.invoke:43-Method.invoke:606-
> Aop
> > > >> Utils.
> > > >> > > > > invokeJoinpointUsingReflection:317-
> > ReflectiveMethodInvocation.
> > > >> > > > > invokeJoinpoint:183
> > > >> > > > > 2017-08-01 13:03:01,667 ERROR [c.c.a.ApiServer]
> > > >> > > > > (catalina-exec-9:ctx-262022ac ctx-77de8cad) (logid:91c02e8f)
> > > >> > unhandled
> > > >> > > > > exception executing api command:
> [Ljava.lang.String;@1979ff2d
> > > >> > > > > java.lang.NullPointerException
> > > >> > > > > at com.cloud.dc.dao.VlanDaoImpl.listVlansForPodByType(
> > > >> > > > > VlanDaoImpl.java:163)
> > > >> > > > > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
> > Method)
> > > >> > > > > at sun.reflect.NativeMethodAccessorImpl.invoke(
> > > >> > > > > NativeMethodAccessorImpl.java:57)
> > > >> > > > > at sun.reflect.DelegatingMethodAccessorImpl.invoke(
> > > >> > > > > DelegatingMethodAccessorImpl.java:43)
> > > >> > > > > at java.lang.reflect.Method.invoke(Method.java:606)
> > > >> > > > > at org.springframework.aop.support.AopUtils.
> > > >> > > > > invokeJoinpointUsingReflection(AopUtils.java:317)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > invokeJoinpoint(ReflectiveMethodInvocation.java:183)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > proceed(ReflectiveMethodInvocation.java:150)
> > > >> > > > > at com.cloud.utils.db.TransactionContextInterceptor.invoke(
> > > >> > > > > TransactionContextInterceptor.java:34)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > proceed(ReflectiveMethodInvocation.java:161)
> > > >> > > > > at org.springframework.aop.interceptor.
> > > >> > > > > ExposeInvocationInterceptor.invoke(
> > ExposeInvocationInterceptor.
> > > >> > > java:91)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > proceed(ReflectiveMethodInvocation.java:172)
> > > >> > > > > at org.springframework.aop.framework.JdkDynamicAopProxy.
> > > >> > > > > invoke(JdkDynamicAopProxy.java:204)
> > > >> > > > > at com.sun.proxy.$Proxy113.listVlansForPodByType(Unknown
> > > Source)
> > > >> > > > > at com.cloud.network.NetworkModelImpl.listPodVlans(
> > > >> > > > > NetworkModelImpl.java:797)
> > > >> > > > > at com.cloud.configuration.ConfigurationManagerImpl$1.
> > > >> > > > > doInTransactionWithoutResult(ConfigurationManagerImpl.java:
> > > 1029)
> > > >> > > > > at com.cloud.utils.db.TransactionCallbackNoReturn.
> > doInTransacti
> > > >> on(
> > > >> > > > > TransactionCallbackNoReturn.java:25)
> > > >> > > > > at com.cloud.utils.db.Transaction$2.doInTransaction(
> > > >> > > > > Transaction.java:50)
> > > >> > > > > at com.cloud.utils.db.Transaction.execute(
> > Transaction.java:40)
> > > >> > > > > at com.cloud.utils.db.Transaction.execute(
> > Transaction.java:47)
> > > >> > > > > at com.cloud.configuration.ConfigurationManagerImpl.
> > deletePod(
> > > >> > > > > ConfigurationManagerImpl.java:1009)
> > > >> > > > > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
> > Method)
> > > >> > > > > at sun.reflect.NativeMethodAccessorImpl.invoke(
> > > >> > > > > NativeMethodAccessorImpl.java:57)
> > > >> > > > > at sun.reflect.DelegatingMethodAccessorImpl.invoke(
> > > >> > > > > DelegatingMethodAccessorImpl.java:43)
> > > >> > > > > at java.lang.reflect.Method.invoke(Method.java:606)
> > > >> > > > > at org.springframework.aop.support.AopUtils.
> > > >> > > > > invokeJoinpointUsingReflection(AopUtils.java:317)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > invokeJoinpoint(ReflectiveMethodInvocation.java:183)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > proceed(ReflectiveMethodInvocation.java:150)
> > > >> > > > > at org.springframework.aop.interceptor.
> > > >> > > > > ExposeInvocationInterceptor.invoke(
> > ExposeInvocationInterceptor.
> > > >> > > java:91)
> > > >> > > > > at org.springframework.aop.framework.
> > > ReflectiveMethodInvocation.
> > > >> > > > > proceed(ReflectiveMethodInvocation.java:172)
> > > >> > > > > at org.springframework.aop.framework.JdkDynamicAopProxy.
> > > >> > > > > invoke(JdkDynamicAopProxy.java:204)
> > > >> > > > > at com.sun.proxy.$Proxy119.deletePod(Unknown Source)
> > > >> > > > > at org.apache.cloudstack.api.command.admin.pod.
> > > >> > > > > DeletePodCmd.execute(DeletePodCmd.java:70)
> > > >> > > > > at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:
> > 150)
> > > >> > > > > at com.cloud.api.ApiServer.queueCommand(ApiServer.java:709)
> > > >> > > > > at com.cloud.api.ApiServer.handleRequest(ApiServer.java:
> 533)
> > > >> > > > > at com.cloud.api.ApiServlet.processRequestInContext(
> > > >> > > > > ApiServlet.java:299)
> > > >> > > > > at com.cloud.api.ApiServlet$1.run(ApiServlet.java:129)
> > > >> > > > > 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:126)
> > > >> > > > > at com.cloud.api.ApiServlet.doGet(ApiServlet.java:88)
> > > >> > > > > at javax.servlet.http.HttpServlet.service(
> > HttpServlet.java:617)
> > > >> > > > > at javax.servlet.http.HttpServlet.service(
> > HttpServlet.java:723)
> > > >> > > > > at org.apache.catalina.core.ApplicationFilterChain.
> > > >> > > > > internalDoFilter(ApplicationFilterChain.java:290)
> > > >> > > > > at org.apache.catalina.core.ApplicationFilterChain.
> doFilter(
> > > >> > > > > ApplicationFilterChain.java:206)
> > > >> > > > > at org.apache.catalina.core.StandardWrapperValve.invoke(
> > > >> > > > > StandardWrapperValve.java:233)
> > > >> > > > > at org.apache.catalina.core.StandardContextValve.invoke(
> > > >> > > > > StandardContextValve.java:191)
> > > >> > > > > at org.apache.catalina.core.StandardHostValve.invoke(
> > > >> > > > > StandardHostValve.java:127)
> > > >> > > > > at org.apache.catalina.valves.ErrorReportValve.invoke(
> > > >> > > > > ErrorReportValve.java:102)
> > > >> > > > > at org.apache.catalina.valves.AccessLogValve.invoke(
> > > >> > > > > AccessLogValve.java:555)
> > > >> > > > > at org.apache.catalina.core.StandardEngineValve.invoke(
> > > >> > > > > StandardEngineValve.java:109)
> > > >> > > > > at org.apache.catalina.connector.CoyoteAdapter.service(
> > > >> > > > > CoyoteAdapter.java:299)
> > > >> > > > > at org.apache.coyote.http11.Http11NioProcessor.process(
> > > >> > > > > Http11NioProcessor.java:896)
> > > >> > > > > at org.apache.coyote.http11.Http11NioProtocol$
> > > >> > > > > Http11ConnectionHandler.process(Http11NioProtocol.java:732)
> > > >> > > > > at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.
> > > >> > > > > run(NioEndpoint.java:2277)
> > > >> > > > > at java.util.concurrent.ThreadPoolExecutor.runWorker(
> > > >> > > > > ThreadPoolExecutor.java:1145)
> > > >> > > > > at java.util.concurrent.ThreadPoolExecutor$Worker.run(
> > > >> > > > > ThreadPoolExecutor.java:615)
> > > >> > > > > at java.lang.Thread.run(Thread.java:748)
> > > >> > > > >
> > > >> > > > >
> > > >> > > > > - - - - - - - - - - - - - - - - - - -
> > > >> > > > >
> > > >> > > > > Rodrigo Baldasso - LHOST
> > > >> > > > >
> > > >> > > > > (51) 9 8419-9861
> > > >> > > > > - - - - - - - - - - - - - - - - - - -
> > > >> > > > > On 01/08/2017 12:08:03, Gabriel Beims Bräscher
> > > >> > > > > wrote:
> > > >> > > > > It might be a bug then.
> > > >> > > > >
> > > >> > > > > I will try to connect the dots. The problem seems to be with
> > the
> > > >> pod
> > > >> > > > then.
> > > >> > > > >
> > > >> > > > > 2017-08-01 12:01 GMT-03:00 Rodrigo Baldasso :
> > > >> > > > >
> > > >> > > > > > Hi, thanks for your reply
> > > >> > > > > >
> > > >> > > > > > I didnt made any changes manually on the database,
> however,
> > > it's
> > > >> > like
> > > >> > > > the
> > > >> > > > > > pod got corrupted after the change. I can't even delete
> the
> > > pod
> > > >> > from
> > > >> > > > the
> > > >> > > > > > zone that throws the exception (nullpointer) also.
> > > >> > > > > >
> > > >> > > > > > I was able to reproduce that in a fresh, clean install. So
> > > maybe
> > > >> > > it's a
> > > >> > > > > bug
> > > >> > > > > > or something related to my environment.
> > > >> > > > > >
> > > >> > > > > > Recreating the pod with the same parameters and settings
> > works
> > > >> > fine.
> > > >> > > > > >
> > > >> > > > > > Enviado de GMail Mobile
> > > >> > > > > >
> > > >> > > > > >
> > > >> > > > > > Em 1 de ago de 2017 11:56, "Gabriel Beims Bräscher"
> > > >> > > > > > escreveu:
> > > >> > > > > >
> > > >> > > > > > You said that it worked before changing the IP range; it
> > might
> > > >> be
> > > >> > > > caused
> > > >> > > > > by
> > > >> > > > > > a database inconsistency related to the IP allocation. Did
> > you
> > > >> make
> > > >> > > any
> > > >> > > > > > manual changes in the database?
> > > >> > > > > >
> > > >> > > > > > The null pointer exception came after the following
> methods
> > > >> > > exectution:
> > > >> > > > > > 1 - it begins the exectution flow to start the VM
> > > >> > > > > > (com.cloud.vm.VirtualMachineManagerImpl.
> orchestrateStart);
> > > >> > > > > > 2 - then it starts the network flow for that VM
> > > >> > > > > > (org.apache.cloudstack.engine.orchestration.
> > > >> > > > > NetworkOrchestrator.prepare);
> > > >> > > > > > 3 - it prepares the NIC
> > > >> > > > > > (org.apache.cloudstack.engine.
> > orchestration.NetworkOrchestra
> > > >> tor.
> > > >> > > > > > prepareNic);
> > > >> > > > > > 4 - reserve the IP address
> > > >> > > > > > (com.cloud.network.guru.DirectPodBasedNetworkGuru.
> reserve);
> > > >> > > > > > 5 - finally it tries to get an IP address, triggering the
> > null
> > > >> > > pointer
> > > >> > > > > > exception (com.cloud.network.guru.
> > DirectPodBasedNetworkGuru.
> > > >> > getIp).
> > > >> > > > > >
> > > >> > > > > > 2017-07-31 13:27 GMT-03:00 Rodrigo Baldasso :
> > > >> > > > > >
> > > >> > > > > > > Thanks for your reply.
> > > >> > > > > > >
> > > >> > > > > > > I'm using 4.9.2.0. I'm posting the full log below!
> > > >> > > > > > >
> > > >> > > > > > > The secondary storage is mounted as NFS.
> > > >> > > > > > >
> > > >> > > > > > > PS: i was able to start SSVM after creating a new zone,
> > > >> however,
> > > >> > > > when I
> > > >> > > > > > > changed the IP range, the error came back again.
> > > >> > > > > > >
> > > >> > > > > > > 2017-07-31 13:23:15,950 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Seq 1-6685312171854790673: Sending {
> Cmd
> > ,
> > > >> > MgmtId:
> > > >> > > > > > > 119779289367307, via: 1(kvm-tqr-01.lhost.net.br), Ver:
> > v1,
> > > >> > Flags:
> > > >> > > > > > 100011,
> > > >> > > > > > > [{"com.cloud.agent.api.StopCommand":{"isProxy":false,
> > > >> > > > > > > "checkBeforeCleanup":false,"vmName":"v-66-VM","
> > > >> > > > > > executeInSequence":false,"
> > > >> > > > > > > wait":0}}]
> > > >> > > > > > > }
> > > >> > > > > > > 2017-07-31 13:23:16,153 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > (AgentManager-Handler-7:null) (logid:) Seq
> > > >> 1-6685312171854790673:
> > > >> > > > > > > Processing: { Ans: , MgmtId: 119779289367307, via: 1,
> Ver:
> > > v1,
> > > >> > > Flags:
> > > >> > > > > > 10,
> > > >> > > > > > > [{"com.cloud.agent.api.StopAnswer":{"result":true,"
> > > wait":0}}]
> > > >> }
> > > >> > > > > > > 2017-07-31 13:23:16,153 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Seq 1-6685312171854790673: Received: {
> > > Ans: ,
> > > >> > > > MgmtId:
> > > >> > > > > > > 119779289367307, via: 1(kvm-tqr-01.lhost.net.br), Ver:
> > v1,
> > > >> > Flags:
> > > >> > > > 10,
> > > >> > > > > {
> > > >> > > > > > > StopAnswer } }
> > > >> > > > > > > 2017-07-31 13:23:16,166 DEBUG [c.c.n.NetworkModelImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Service SecurityGroup is not supported
> in
> > > the
> > > >> > > > network
> > > >> > > > > > > id=204
> > > >> > > > > > > 2017-07-31 13:23:16,201 DEBUG [o.a.c.e.o.
> > > NetworkOrchestrator]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Asking VirtualRouter to release
> > > >> > > > > > > NicProfile[196-66-cee1cba9-7a24-44cf-a5c2-24f2e5dff1ae-
> > > null-
> > > >> null
> > > >> > > > > > > 2017-07-31 13:23:16,211 DEBUG
> > [c.c.v.VirtualMachineManagerIm
> > > >> pl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Successfully released network resources
> > for
> > > >> the
> > > >> > vm
> > > >> > > > > > > VM[ConsoleProxy|v-66-VM]
> > > >> > > > > > > 2017-07-31 13:23:16,211 DEBUG
> > [c.c.v.VirtualMachineManagerIm
> > > >> pl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Successfully cleanued up resources for
> > the
> > > vm
> > > >> > > > > > > VM[ConsoleProxy|v-66-VM] in Starting state
> > > >> > > > > > > 2017-07-31 13:23:16,314 DEBUG
> [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) VM state transitted from :Starting to
> > > Stopped
> > > >> > with
> > > >> > > > > > event:
> > > >> > > > > > > OperationFailedvm's original host id: null new host id:
> > null
> > > >> host
> > > >> > > id
> > > >> > > > > > before
> > > >> > > > > > > state transition: 1
> > > >> > > > > > > 2017-07-31 13:23:16,324 DEBUG
> [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Hosts's actual total CPU: 54432 and CPU
> > > after
> > > >> > > > applying
> > > >> > > > > > > overprovisioning: 54432
> > > >> > > > > > > 2017-07-31 13:23:16,324 DEBUG
> [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Hosts's actual total RAM: 7169134592
> > > >> and RAM
> > > >> > after
> > > >> > > > > > > applying overprovisioning: 7169134592
> > > >> > > > > > > 2017-07-31 13:23:16,325 DEBUG
> [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) release cpu from host: 1, old used:
> > > >> > 500,reserved:
> > > >> > > 0,
> > > >> > > > > > > actual total: 54432, total with overprovisioning: 54432;
> > new
> > > >> > used:
> > > >> > > > > > > 0,reserved:0; movedfromreserved:
> > false,moveToReserveredfalse
> > > >> > > > > > > 2017-07-31 13:23:16,325 DEBUG
> [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) release mem from host: 1, old used:
> > > >> > > > > 1073741824,reserved:
> > > >> > > > > > > 0, total: 7169134592 ; new used:
> > > >> 0,reserved:0; movedfromreserved:
> > > >> > > > > > > false,moveToReserveredfalse
> > > >> > > > > > > 2017-07-31 13:23:16,384 ERROR
> > [c.c.v.VmWorkJobHandlerProxy]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Invocation exception, caused by:
> > > >> > > > > > > java.lang.NullPointerException
> > > >> > > > > > > 2017-07-31 13:23:16,384 INFO
> [c.c.v.VmWorkJobHandlerProxy]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272
> > > >> ctx-06907041)
> > > >> > > > > > > (logid:7a78f881) Rethrow exception
> > > >> java.lang.NullPointerException
> > > >> > > > > > > 2017-07-31 13:23:16,384 DEBUG
> [c.c.v.VmWorkJobDispatcher]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272)
> > > >> > > (logid:7a78f881)
> > > >> > > > > Done
> > > >> > > > > > > with run of VM work job: com.cloud.vm.VmWorkStart for VM
> > 66,
> > > >> job
> > > >> > > > > origin:
> > > >> > > > > > > 131
> > > >> > > > > > > 2017-07-31 13:23:16,384 ERROR
> [c.c.v.VmWorkJobDispatcher]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272)
> > > >> > > (logid:7a78f881)
> > > >> > > > > > Unable
> > > >> > > > > > > to complete AsyncJobVO {id:272, userId: 1, accountId: 1,
> > > >> > > > instanceType:
> > > >> > > > > > > null, instanceId: null, cmd: com.cloud.vm.VmWorkStart,
> > > >> cmdInfo:
> > > >> > > > > > > rO0ABXNyABhjb20uY2xvdWQudm0uVm
> > > 1Xb3JrU3RhcnR9cMGsvxz73gIAC0oA
> > > >> > > > > > > BGRjSWRMAAZhdm9pZHN0ADBMY29tL2
> > > Nsb3VkL2RlcGxveS9EZXBsb3ltZW50
> > > >> > > > > > > UGxhbm5lciRFeGNsdWRlTGlzdDtMAA
> > > ljbHVzdGVySWR0ABBMamF2YS9sYW5n
> > > >> > > > > > > L0xvbmc7TAAGaG9zdElkcQB-AAJMAAtqb3VybmFsTmFtZXQAEkxqYX
> > > >> > > > > > > ZhL2xhbmcvU3RyaW5nO0wAEXBoeXNpY2FsTmV0d29ya0lkcQB-
> > > >> > > > AAJMAAdwbGFubmVycQB-
> > > >> > > > > > > AANMAAVwb2RJZHEAfgACTAAGcG9vbElkcQB-
> > > >> > AAJMAAlyYXdQYXJhbXN0AA9MamF2YS
> > > >> > > > > > > 91dGlsL01hcDtMAA1yZXNlcnZhdGlvbklkcQB-
> > > >> > > AAN4cgATY29tLmNsb3VkLnZtLlZtV2
> > > >> > > > > > 9ya5-
> > > >> > > > > > > ZtlbwJWdrAgAESgAJYWNjb3VudElkS
> > > gAGdXNlcklkSgAEdm1JZEwAC2hhbmR
> > > >> > > > > > sZXJOYW1lcQB-
> > > >> > > > > > > AAN4cAAAAAAAAAABAAAAAAAAAAEAAA
> > > AAAAAAQnQAGVZpcnR1YWxNYWNoaW5l
> > > >> > > > > > > TWFuYWdlckltcGwAAAAAAAAAAHBwcHBwcHBwcHA,
> > > >> > > > > > > cmdVersion: 0, status: IN_PROGRESS, processStatus: 0,
> > > >> resultCode:
> > > >> > > 0,
> > > >> > > > > > > result: null, initMsid: 119779289367307, completeMsid:
> > null,
> > > >> > > > > lastUpdated:
> > > >> > > > > > > null, lastPolled: null, created: Mon Jul 31 13:23:14 BRT
> > > >> 2017},
> > > >> > job
> > > >> > > > > > > origin:131
> > > >> > > > > > > java.lang.NullPointerException
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.network.guru.DirectPodBasedNetworkGuru$2.
> > > >> > > > > > > doInTransactionWithoutResult(DirectPodBasedNetworkGuru.
> > > java:
> > > >> 177)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.utils.db.TransactionCallbackWithExcepti
> > > >> > > > > > > onNoReturn.doInTransaction(
> TransactionCallbackWithExcepti
> > > >> > > > > > > onNoReturn.java:25)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.utils.db.TransactionCallbackWithExcepti
> > > >> > > > > > > onNoReturn.doInTransaction(
> TransactionCallbackWithExcepti
> > > >> > > > > > > onNoReturn.java:21)
> > > >> > > > > > > at com.cloud.utils.db.Transaction
> > > >> .execute(Transaction.java:40)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.network.guru.DirectPodBasedNetworkGuru.getIp(
> > > >> > > > > > > DirectPodBasedNetworkGuru.java:170)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.network.guru.DirectPodBasedNetworkGuru.
> reserve(
> > > >> > > > > > > DirectPodBasedNetworkGuru.java:157)
> > > >> > > > > > > at
> > > >> > > > > > > org.apache.cloudstack.engine.orchestration.
> > > NetworkOrchestrat
> > > >> or.
> > > >> > > > > > prepareNic(
> > > >> > > > > > > NetworkOrchestrator.java:1350)
> > > >> > > > > > > at
> > > >> > > > > > > org.apache.cloudstack.engine.orchestration.
> > > >> > > > > NetworkOrchestrator.prepare(
> > > >> > > > > > > NetworkOrchestrator.java:1321)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.vm.VirtualMachineManagerImpl.
> orchestrateStart(
> > > >> > > > > > > VirtualMachineManagerImpl.java:997)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.vm.VirtualMachineManagerImpl.
> orchestrateStart(
> > > >> > > > > > > VirtualMachineManagerImpl.java:4605)
> > > >> > > > > > > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
> > > >> Method)
> > > >> > > > > > > at
> > > >> > > > > > > sun.reflect.NativeMethodAccessorImpl.invoke(
> > > >> > > > > > NativeMethodAccessorImpl.java:
> > > >> > > > > > > 57)
> > > >> > > > > > > at
> > > >> > > > > > > sun.reflect.DelegatingMethodAccessorImpl.invoke(
> > > >> > > > > > > DelegatingMethodAccessorImpl.java:43)
> > > >> > > > > > > at java.lang.reflect.Method.invoke(Method.java:606)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(
> > > >> > > > > > > VmWorkJobHandlerProxy.java:107)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(
> > > >> > > > > > > VirtualMachineManagerImpl.java:4766)
> > > >> > > > > > > at
> > > >> > > > > > > com.cloud.vm.VmWorkJobDispatcher.runJob(
> > > >> > > > VmWorkJobDispatcher.java:102)
> > > >> > > > > > > at
> > > >> > > > > > > org.apache.cloudstack.framework.jobs.impl.
> > > AsyncJobManagerImp
> > > >> l$5.
> > > >> > > > > > > runInContext(AsyncJobManagerImpl.java:554)
> > > >> > > > > > > at
> > > >> > > > > > > org.apache.cloudstack.managed.context.
> > > >> > > ManagedContextRunnable$1.run(
> > > >> > > > > > > ManagedContextRunnable.java:49)
> > > >> > > > > > > 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
> > > >> > > > > > > org.apache.cloudstack.managed.context.
> > > >> > ManagedContextRunnable.run(
> > > >> > > > > > > ManagedContextRunnable.java:46)
> > > >> > > > > > > at
> > > >> > > > > > > org.apache.cloudstack.framework.jobs.impl.
> > > >> > > AsyncJobManagerImpl$5.run(
> > > >> > > > > > > AsyncJobManagerImpl.java:502)
> > > >> > > > > > > at
> > > >> > > > > > > java.util.concurrent.Executors$RunnableAdapter.
> > > >> > > > > call(Executors.java:473)
> > > >> > > > > > > at java.util.concurrent.FutureTask.run(FutureTask.
> > java:262)
> > > >> > > > > > > at
> > > >> > > > > > > java.util.concurrent.ThreadPoolExecutor.runWorker(
> > > >> > > > > > > ThreadPoolExecutor.java:1145)
> > > >> > > > > > > at
> > > >> > > > > > > java.util.concurrent.ThreadPoolExecutor$Worker.run(
> > > >> > > > > > > ThreadPoolExecutor.java:615)
> > > >> > > > > > > at java.lang.Thread.run(Thread.java:748)
> > > >> > > > > > > 2017-07-31 13:23:16,388 DEBUG
> > [o.a.c.f.j.i.AsyncJobManagerIm
> > > >> pl]
> > > >> > > > > > > (Work-Job-Executor-6:ctx-e8c72967 job-131/job-272)
> > > >> > > (logid:7a78f881)
> > > >> > > > > > > Complete async job-272, jobStatus: FAILED, resultCode:
> 0,
> > > >> result:
> > > >> > > > > > > rO0ABXNyAB5qYXZhLmxhbmcuTnVsbF
> BvaW50ZXJFeGNlcHRpb25HpaGO_
> > > >> > > > > > > zHhuAIAAHhyABpqYXZhLmxhbmcuUnV
> > > udGltZUV4Y2VwdGlvbp5fBkcKNIPlA
> > > >> > > > > > > gAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-
> > > >> > > > GjscxAIAAHhyABNqYXZhLmxhbmcuVG
> > > >> > > > > > > hyb3dhYmxl1cY1Jzl3uMsDAARMAAVj
> > > YXVzZXQAFUxqYXZhL2xhbmcvVGhyb3
> > > >> > > > > > > dhYmxlO0wADWRldGFpbE1lc3NhZ2V0
> > > ABJMamF2YS9sYW5nL1N0cmluZztbAA
> > > >> > > > > > > pzdGFja1RyYWNldAAeW0xqYXZhL2xh
> > > bmcvU3RhY2tUcmFjZUVsZW1lbnQ7TA
> > > >> > > > > > > AUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0
> > > ABBMamF2YS91dGlsL0xpc3Q7eHBxAH
> > > >> > > > > > > 4ACHB1cgAeW0xqYXZhLmxhbmcuU3Rh
> > > Y2tUcmFjZUVsZW1lbnQ7AkYqPDz9Ij
> > > >> > > > > > > kCAAB4cAAAAB1zcgAbamF2YS5sYW5n
> > > LlN0YWNrVHJhY2VFbGVtZW50YQnFmi
> > > >> > > > > > > Y23YUCAARJAApsaW5lTnVtYmVyTAAO
> > > ZGVjbGFyaW5nQ2xhc3NxAH4ABUwACG
> > > >> > > > > > ZpbGVOYW1lcQB-
> > > >> > > > > > > AAVMAAptZXRob2ROYW1lcQB-AAV4cAAAALF0ADJjb20uY2xvdWQubm
> > > >> > > > > > > V0d29yay5ndXJ1LkRpcmVjdFBvZEJh
> > > c2VkTmV0d29ya0d1cnUkMnQAHkRpcm
> > > >> > > > > > > VjdFBvZEJhc2VkTmV0d29ya0d1cnUu
> > > amF2YXQAHGRvSW5UcmFuc2FjdGlvbl
> > > >> > > > > > > dpdGhvdXRSZXN1bHRzcQB-AAsAAAAZdAA7Y29tLmNsb3VkLnV0aW
> > > >> > > > > > > xzLmRiLlRyYW5zYWN0aW9uQ2FsbGJh
> > > Y2tXaXRoRXhjZXB0aW9uTm9SZXR1cm
> > > >> > > > > > > 50AC1UcmFuc2FjdGlvbkNhbGxiYWNr
> > > V2l0aEV4Y2VwdGlvbk5vUmV0dXJuLm
> > > >> > > > > > > phdmF0AA9kb0luVHJhbnNhY3Rpb25zcQB-AAsAAAAVcQB-
> > > >> > > > > > > ABFxAH4AEnEAfgATc3EAfgALAAAAKH
> > > QAHmNvbS5jbG91ZC51dGlscy5kYi5U
> > > >> > > > > > > cmFuc2FjdGlvbnQAEFRyYW5zYWN0aW
> > > 9uLmphdmF0AAdleGVjdXRlc3EAfgAL
> > > >> > > > > > > AAAAqnQAMGNvbS5jbG91ZC5uZXR3b3
> > > JrLmd1cnUuRGlyZWN0UG9kQmFzZWRO
> > > >> > > > > > > ZXR3b3JrR3VydXEAfgAOdAAFZ2V0SXBzcQB-AAsAAACdcQB-
> > > >> > > > > > > ABpxAH4ADnQAB3Jlc2VydmVzcQB-AAsAAAVGdAA-
> > > >> > > > b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm
> > > >> > > > > > > VuZ2luZS5vcmNoZXN0cmF0aW9uLk5l
> > > dHdvcmtPcmNoZXN0cmF0b3J0ABhOZX
> > > >> > > > > > > R3b3JrT3JjaGVzdHJhdG9yLmphdmF0
> > > AApwcmVwYXJlTmljc3EAfgALAAAFKX
> > > >> > > > EAfgAfcQB-
> > > >> > > > > > > ACB0AAdwcmVwYXJlc3EAfgALAAAD5X
> > > QAJmNvbS5jbG91ZC52bS5WaXJ0dWFs
> > > >> > > > > > > TWFjaGluZU1hbmFnZXJJbXBsdAAeVm
> > > lydHVhbE1hY2hpbmVNYW5hZ2VySW1w
> > > >> > > > > > > bC5qYXZhdAAQb3JjaGVzdHJhdGVTdG
> > > FydHNxAH4ACwAAEf1xAH4AJXEAfgAm
> > > >> > > > > > > cQB-ACdzcQB-AAv____-dAAkc3VuLnJlZmxlY3QuTmF0aXZlTW
> > > >> > > > > > > V0aG9kQWNjZXNzb3JJbXBsdAAdTmF0
> > > aXZlTWV0aG9kQWNjZXNzb3JJbXBsLm
> > > >> > > > > > > phdmF0AAdpbnZva2Uwc3EAfgALAAAA
> > > OXEAfgAqcQB-ACt0AAZpbnZva2VzcQ
> > > >> B-
> > > >> > > > > > > AAsAAAArdAAoc3VuLnJlZmxlY3QuRG
> > > VsZWdhdGluZ01ldGhvZEFjY2Vzc29y
> > > >> > > > > > > SW1wbHQAIURlbGVnYXRpbmdNZXRob2
> > > RBY2Nlc3NvckltcGwuamF2YXEAfgAu
> > > >> > > > > > > c3EAfgALAAACXnQAGGphdmEubGFuZy
> > > 5yZWZsZWN0Lk1ldGhvZHQAC01ldGhv
> > > >> > > > > > > ZC5qYXZhcQB-AC5zcQB-AAsAAABrdAAiY29tLmNsb3VkLnZtLl
> > > >> > > > > > > ZtV29ya0pvYkhhbmRsZXJQcm94eXQA
> > > GlZtV29ya0pvYkhhbmRsZXJQcm94eS
> > > >> > > > > > > 5qYXZhdAAPaGFuZGxlVm1Xb3JrSm9ic3EAfgALAAASnnEAfgAlcQB-
> > > >> > > > > > > ACZxAH4AOHNxAH4ACwAAAGZ0ACBjb2
> > > 0uY2xvdWQudm0uVm1Xb3JrSm9iRGlz
> > > >> > > > > > > cGF0Y2hlcnQAGFZtV29ya0pvYkRpc3
> > > BhdGNoZXIuamF2YXQABnJ1bkpvYnNx
> > > >> > > > > > > AH4ACwAAAip0AD9vcmcuYXBhY2hlLm
> > > Nsb3Vkc3RhY2suZnJhbWV3b3JrLmpv
> > > >> > > > > > > YnMuaW1wbC5Bc3luY0pvYk1hbmFnZX
> > > JJbXBsJDV0ABhBc3luY0pvYk1hbmFn
> > > >> > > > > > > ZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-
> > > >> > > > > > > b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm
> > > 1hbmFnZWQuY29udGV4dC5NYW5hZ2Vk
> > > >> > > > > > > Q29udGV4dFJ1bm5hYmxlJDF0ABtNYW
> > > 5hZ2VkQ29udGV4dFJ1bm5hYmxlLmph
> > > >> > > > > > > dmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG
> > > >> > > > > > > 91ZHN0YWNrLm1hbmFnZWQuY29udGV4
> > > dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ2
> > > >> > > > > > > 9udGV4dCQxdAAaRGVmYXVsdE1hbmFn
> > > ZWRDb250ZXh0LmphdmF0AARjYWxsc3
> > > >> > > > > > > EAfgALAAAAZ3QAQG9yZy5hcGFjaGUu
> > > Y2xvdWRzdGFjay5tYW5hZ2VkLmNvbn
> > > >> > > > > > > RleHQuaW1wbC5EZWZhdWx0TWFuYWdl
> > > ZENvbnRleHRxAH4ASHQAD2NhbGxXaX
> > > >> > > > > > > RoQ29udGV4dHNxAH4ACwAAADVxAH4A
> > > S3EAfgBIdAAOcnVuV2l0aENvbnRleH
> > > >> > RzcQB-
> > > >> > > > > > > AAsAAAAudAA8b3JnLmFwYWNoZS5jbG
> > > 91ZHN0YWNrLm1hbmFnZWQuY29udGV4
> > > >> > > > > > > dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-
> > > >> > AERxAH4ARXNxAH4ACwAAAfZxAH4AP3
> > > >> > > > > > > EAfgBAcQB-AEVzcQB-AAsAAAHZdAAuamF2YS51dGlsLmNvbm
> > > >> > > > > > > N1cnJlbnQuRXhlY3V0b3JzJFJ1bm5h
> > > YmxlQWRhcHRlcnQADkV4ZWN1dG9ycy
> > > >> > > > > > > 5qYXZhcQB-AElzcQB-AAsAAAEGdAAfamF2YS51dGlsLmNvbm
> > > >> > > > > > > N1cnJlbnQuRnV0dXJlVGFza3QAD0Z1
> > > dHVyZVRhc2suamF2YXEAfgBFc3EAfg
> > > >> > > > > > > ALAAAEeXQAJ2phdmEudXRpbC5jb25j
> > > dXJyZW50LlRocmVhZFBvb2xFeGVjdX
> > > >> > > > > > > RvcnQAF1RocmVhZFBvb2xFeGVjdXRv
> > > ci5qYXZhdAAJcnVuV29ya2Vyc3EAfg
> > > >> > > > > > > ALAAACZ3QALmphdmEudXRpbC5jb25j
> > > dXJyZW50LlRocmVhZFBvb2xFeGVjdX
> > > >> > > > > > > RvciRXb3JrZXJxAH4AWnEAfgBFc3EA
> > > fgALAAAC7HQAEGphdmEubGFuZy5UaH
> > > >> > > > > > > JlYWR0AAtUaHJlYWQuamF2YXEAfgBF
> > > c3IAJmphdmEudXRpbC5Db2xsZWN0aW
> > > >> > > > > > > 9ucyRVbm1vZGlmaWFibGVMaXN0_A8lMbXsjhACAAFMAARsaXN0cQB-
> > > >> > > > > > > AAd4cgAsamF2YS51dGlsLkNvbGxlY3
> > > Rpb25zJFVubW9kaWZpYWJsZUNvbGxl
> > > >> > > > > > > Y3Rpb24ZQgCAy173HgIAAUwAAWN0AB
> > > ZMamF2YS91dGlsL0NvbGxlY3Rpb247
> > > >> > > > > > > eHBzcgATamF2YS51dGlsLkFycmF5TG
> > > lzdHiB0h2Zx2GdAwABSQAEc2l6ZXhw
> > > >> > > > > > > AAAAAHcEAAAAAHhxAH4AZng
> > > >> > > > > > >
> > > >> > > > > > >
> > > >> > > > > > > 2017-07-28 0:15 GMT-03:00 Gabriel Beims Bräscher :
> > > >> > > > > > >
> > > >> > > > > > > > Hi Rodrigo,
> > > >> > > > > > > >
> > > >> > > > > > > > Which version of CloudStack are you using? Is there
> any
> > > >> > exception
> > > >> > > > > stack
> > > >> > > > > > > in
> > > >> > > > > > > > the log? Are you using advanced or basic network? Is
> > there
> > > >> any
> > > >> > > > > > connection
> > > >> > > > > > > > problem?
> > > >> > > > > > > >
> > > >> > > > > > > > Are you using Swift as Secondary Storage? If yes,
> there
> > is
> > > >> an
> > > >> > > open
> > > >> > > > > > issue
> > > >> > > > > > > > "CLOUDSTACK-7443: Cannot launch SSVMs when using Swift
> > as
> > > >> > > Secondary
> > > >> > > > > > > > Storage" (https://issues.apache.org/
> > > >> > jira/browse/CLOUDSTACK-7443)
> > > >> > > > > > > >
> > > >> > > > > > > > Can you please review the log? Seems that there are
> > > missing
> > > >> > parts
> > > >> > > > > from
> > > >> > > > > > > the
> > > >> > > > > > > > presented log. One example is the line "2017-07-27
> > > >> 22:30:00,253
> > > >> > > > DEBUG
> > > >> > > > > > > > [c.c.c.CapacityManagerImpl]". The full log should
> > contain
> > > >> "VM
> > > >> > > state
> > > >> > > > > > > > transitted from :" + oldState + " to " + newState + "
> > with
> > > >> > event:
> > > >> > > > " +
> > > >> > > > > > > event
> > > >> > > > > > > > + "vm's original host id: " + vm.getLastHostId() + "
> new
> > > >> host
> > > >> > id:
> > > >> > > > " +
> > > >> > > > > > > > vm.getHostId() + " host id before state transition: "
> +
> > > >> > > oldHostId".
> > > >> > > > > > > >
> > > >> > > > > > > > Cheers,
> > > >> > > > > > > > Gabriel.
> > > >> > > > > > > >
> > > >> > > > > > > > 2017-07-27 22:37 GMT-03:00 Rodrigo Baldasso :
> > > >> > > > > > > >
> > > >> > > > > > > > > Hi everyone,
> > > >> > > > > > > > >
> > > >> > > > > > > > > I'm trying to set up my cloudstack environment but
> > > >> despite my
> > > >> > > > best
> > > >> > > > > > > > efforts,
> > > >> > > > > > > > > the system isn't starting the ssvm's.. on my agent
> log
> > > >> all i
> > > >> > > can
> > > >> > > > > see
> > > >> > > > > > > is:
> > > >> > > > > > > > >
> > > >> > > > > > > > > [kvm.resource.LibvirtConnection]
> > > >> > (agentRequest-Handler-5:null)
> > > >> > > > > > > > > (logid:4acd7d3e) Can not find a connection for
> > Instance
> > > >> > > v-52-VM.
> > > >> > > > > > > Assuming
> > > >> > > > > > > > > the default connection.
> > > >> > > > > > > > >
> > > >> > > > > > > > > On the manager console, this is the error:
> > > >> > > > > > > > >
> > > >> > > > > > > > > 2017-07-27 22:29:59,853 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Seq 1-2810527642455900231:
> > > >> > > > vm-tqr-01.lhost.net.br
> > > >> > > > > ),
> > > >> > > > > > > > Ver:
> > > >> > > > > > > > > v1, Flags: 100011,
> > > >> > > > > > > > > [{"com.cloud.agent.api.
> StopCommand":{"isProxy":false,
> > > >> > > > > > > > > "checkBeforeCleanup":false,"
> > vmName":"v-52-VM","executeI
> > > >> > > > > > > > > 2017-07-27 22:29:59,952 DEBUG [o.a.c.f.j.i.
> > > >> > > AsyncJobManagerImpl]
> > > >> > > > > > > > > (secstorage-1:ctx-48b34715) (logid:526bc485) Sync
> > > job-547
> > > >> > > > execution
> > > >> > > > > > on
> > > >> > > > > > > > > object VmWorkJobQueue.
> > > >> > > > > > > > > 2017-07-27 22:30:00,042 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > > > (AgentManager-Handler-7:null) (logid:) Seq
> > > >> > > 1-2810527642455900231:
> > > >> > > > > > > > > Processing: { Ans: , MgmtId:
> > > >> > > > > > > > > 1197792893673.api.StopAnswer":
> > > {"result":true,"wait":0}}]
> > > >> }
> > > >> > > > > > > > > 2017-07-27 22:30:00,043 DEBUG [c.c.a.t.Request]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Seq 1-2810527642455900231: 1(
> > > >> > > > > > kvm-tqr-01.lhost.net.br
> > > >> > > > > > > ),
> > > >> > > > > > > > > Ver: v1, Flags: 10, { StopAnswer } }
> > > >> > > > > > > > > 2017-07-27 22:30:00,185 DEBUG [o.a.c.e.o.
> > > >> > NetworkOrchestrator]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Asking
> Virtua-42a5-a288-2582921a1946-
> > > >> > > null-null
> > > >> > > > > > > > > 2017-07-27 22:30:00,185 DEBUG [o.a.c.e.o.
> > > >> > NetworkOrchestrator]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Asking Securi129-658b-42a5-a288-
> > > >> > > > > > > 2582921a1946-null-null
> > > >> > > > > > > > > 2017-07-27 22:30:00,189 DEBUG [c.c.v.
> > > >> > > VirtualMachineManagerImpl]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) SuccessfullProxy|v-52-VM]
> > > >> > > > > > > > > 2017-07-27 22:30:00,190 DEBUG [c.c.v.
> > > >> > > VirtualMachineManagerImpl]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Successfull|v-52-VM] in Starting
> > state
> > > >> > > > > > > > > 2017-07-27 22:30:00,253 DEBUG
> > > [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) VM state transittFailedvm's
> original
> > > host
> > > >> > id:
> > > >> > > > null
> > > >> > > > > > new
> > > >> > > > > > > > > host id: null host id before state transition: 1
> > > >> > > > > > > > > 2017-07-27 22:30:00,259 DEBUG
> > > [c.c.c.CapacityManagerImpl]
> > > >> > > > > > > > > (Work-Job-Executor-54:ctx-a9fdb60b job-169/job-546
> > > >> > > ctx-23fba537)
> > > >> > > > > > > > > (logid:4acd7d3e) Hosts's actual toning: 54432
> > > >> > > > > > > > >
> > > >> > > > > > > >
> > > >> > > > > > >
> > > >> > > > > >
> > > >> > > > >
> > > >> > > >
> > > >> > > >
> > > >> > > >
> > > >> > > > --
> > > >> > > > Rafael Weingärtner
> > > >> > > >
> > > >> > >
> > > >> > >
> > > >> > >
> > > >> > > --
> > > >> > > Rafael Weingärtner
> > > >> > >
> > > >> >
> > > >> >
> > > >> >
> > > >> > --
> > > >> > Rafael Weingärtner
> > > >> >
> > > >>
> > > >>
> > > >>
> > > >> --
> > > >> Rafael Weingärtner
> > > >>
> > > >
> > > >
> > > >
> > > > --
> > > > Rafael Weingärtner
> > > >
> > >
> > >
> > >
> > > --
> > > Rafael Weingärtner
> > >
> >
> >
> >
> > --
> > Rafael Weingärtner
> >
>
>
>
> --
> Rafael Weingärtner
>



-- 
Rafael Weingärtner

Mime
  • Unnamed multipart/alternative (inline, None, 0 bytes)
View raw message