You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Alena Prokharchyk (JIRA)" <ji...@apache.org> on 2014/07/24 00:58:38 UTC

[jira] [Commented] (CLOUDSTACK-7165) [Automation] NPE observed during restart and expunge VM

    [ https://issues.apache.org/jira/browse/CLOUDSTACK-7165?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14072505#comment-14072505 ] 

Alena Prokharchyk commented on CLOUDSTACK-7165:
-----------------------------------------------

Reducing the priority to Critical as this problem is a race condition, and doesn't block any other operations. The problem happens when do the access check for the VM's owner, and the vm's owner is removed right before the check was performed.



> [Automation] NPE observed during restart and expunge VM 
> --------------------------------------------------------
>
>                 Key: CLOUDSTACK-7165
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-7165
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: Management Server
>    Affects Versions: 4.5.0
>         Environment: KVM (RHEL 6.3)
>            Reporter: Rayees Namathponnan
>            Assignee: edison su
>            Priority: Critical
>             Fix For: 4.5.0
>
>         Attachments: Jully_22_KVM.rar
>
>
> This issue is observed with latest  automation run . NPE observed during restart abd expunge VM 
> 2014-07-22 10:52:34,081 DEBUG [c.c.a.ApiServlet] (catalina-exec-10:ctx-06101cd2) ===START===  10.150.19.7 -- GET  command=expungeVirtualMachine&id=f991f7fa-1376-486b-be92-894638942c14&response=json&sessionkey=HKY1QrnQ2q8iKG%2FGN%2FaRArKCny4%3D&_=1406051549738
> 2014-07-22 10:52:34,099 ERROR [c.c.a.ApiServer] (catalina-exec-10:ctx-06101cd2 ctx-e8e32432) unhandled exception executing api command: [Ljava.lang.String;@23210413
> java.lang.NullPointerException
>         at com.cloud.user.AccountManagerImpl.checkAccess(AccountManagerImpl.java:494)
>         at com.cloud.user.AccountManagerImpl.checkAccess(AccountManagerImpl.java:482)
>         at sun.reflect.GeneratedMethodAccessor146.invoke(Unknown Source)
>         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.$Proxy102.checkAccess(Unknown Source)
>         at com.cloud.api.dispatch.ParamProcessWorker.doAccessChecks(ParamProcessWorker.java:232)
>         at com.cloud.api.dispatch.ParamProcessWorker.processParameters(ParamProcessWorker.java:217)
>         at com.cloud.api.dispatch.ParamProcessWorker.handle(ParamProcessWorker.java:89)
>         at com.cloud.api.dispatch.DispatchChain.dispatch(DispatchChain.java:37)
>         at com.cloud.api.ApiServer.queueCommand(ApiServer.java:635)
>         at com.cloud.api.ApiServer.handleRequest(ApiServer.java:517)
>         at com.cloud.api.ApiServlet.processRequestInContext(ApiServlet.java:317)
>         at com.cloud.api.ApiServlet$1.run(ApiServlet.java:118)
>         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:115)
>         at com.cloud.api.ApiServlet.doGet(ApiServlet.java:77)
>         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(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:298)
>         at org.apache.coyote.http11.Http11NioProcessor.process(Http11NioProcessor.java:889)
>         at org.apache.coyote.http11.Http11NioProtocol$Http11ConnectionHandler.process(Http11NioProtocol.java:721)
>         at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEndpoint.java:2268)
>         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:744)
> 2014-07-22 10:52:34,101 DEBUG [c.c.a.ApiServlet] (catalina-exec-10:ctx-06101cd2 ctx-e8e32432) ===END===  10.150.19.7 -- GET  command=expungeVirtualMachine&id=f991f7fa-1376-486b-be92-894638942c14&response=json&sessionkey=HKY1QrnQ2q8iKG%2FGN%2FaRArKCny4%3D&_=1406051549738
> 2014-07-22 10:52:34,893 DEBUG [o.a.c.f.j.i.SyncQueueManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-0d2a26bd) Queue (queue id, sync type, sync id) - (640,VmWorkJobQueue, 243) is reaching concurrency limit 1
> 2014-07-22 10:52:34,907 DEBUG [c.c.a.ApiServlet] (catalina-exec-3:ctx-28a9ac80) ===START===  10.150.19.7 -- GET  command=listVirtualMachines&id=1297d795-e53f-475b-9686-a9a47629e0ef&response=json&sessionkey=HKY1QrnQ2q8iKG%2FGN%2FaRArKCny4%3D&_=1406051550705



--
This message was sent by Atlassian JIRA
(v6.2#6252)