[
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)
