[ 
https://issues.apache.org/jira/browse/GEODE-7403?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
 ]

Kirk Lund updated GEODE-7403:
-----------------------------
    Description: 
The background dunit locator is logging an error-level message with 
{{java.lang.ClassNotFoundException: 
org.apache.geode.internal.logging.LogService}} which does not seem to be found 
by the LogConsumer (aka the dunit grep-logs-for-suspect-strings). 

Note: LogService recently moved to a new package: 
{{org.apache.geode.logging.internal.log4j.api.LogService}}. The error-level 
message shows that the background dunit locator is trying to use the LogService 
in its old package.

I don't know if this is consistent or intermittent. I also don't know if this 
occurs in both CLI and IntelliJ runs of dunit tests. I'll try to confirm 
when/how this happens and add more details.

Using git grep for {{org.apache.geode.internal.logging.LogService}} finds no 
results, so I suspect this may involve the old geode versions that are pulled 
down locally for rolling upgrade and backwards compatibility tests. I'm 
concerned that those upgrade tests are creating invalid classpaths that mix 
versions of Geode.

The following is logged by the dunit locator as one long stack. I've divided it 
into three sections with markdown to facilitate seeing the two Causes without 
scrolling.

{noformat}
[error 2019/11/01 14:48:50.877 PDT <RMI TCP Connection(1)-127.0.0.1> tid=0x13] 
Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean 
with name 'managementControllerAdvice' defined in file 
[/Users/klund/dev/gemfire/geode/geode-dunit/dunit/locator/GemFire_klund/services/http/0.0.0.0_7070_management_8c20b9f3/webapp/WEB-INF/classes/org/apache/geode/management/internal/rest/controllers/ManagementControllerAdvice.class]:
 Instantiation of bean failed; nested exception is 
java.lang.NoClassDefFoundError: org/apache/geode/internal/logging/LogService
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1159)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1103)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:511)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:481)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:312)
        at 
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:308)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
        at 
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:764)
        at 
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:867)
        at 
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542)
        at 
org.springframework.web.servlet.FrameworkServlet.configureAndRefreshWebApplicationContext(FrameworkServlet.java:668)
        at 
org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:634)
        at 
org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:682)
        at 
org.springframework.web.servlet.FrameworkServlet.initWebApplicationContext(FrameworkServlet.java:553)
        at 
org.springframework.web.servlet.FrameworkServlet.initServletBean(FrameworkServlet.java:494)
        at 
org.springframework.web.servlet.HttpServletBean.init(HttpServletBean.java:171)
        at javax.servlet.GenericServlet.init(GenericServlet.java:244)
        at 
org.eclipse.jetty.servlet.ServletHolder.initServlet(ServletHolder.java:599)
        at 
org.eclipse.jetty.servlet.ServletHolder.initialize(ServletHolder.java:425)
        at 
org.eclipse.jetty.servlet.ServletHandler.lambda$initialize$0(ServletHandler.java:751)
        at 
java.util.stream.SortedOps$SizedRefSortingSink.end(SortedOps.java:352)
        at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:482)
        at 
java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:471)
        at 
java.util.stream.StreamSpliterators$WrappingSpliterator.forEachRemaining(StreamSpliterators.java:312)
        at 
java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:743)
        at 
java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:742)
        at 
java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:580)
        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:744)
        at 
org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:361)
        at 
org.eclipse.jetty.webapp.WebAppContext.startWebapp(WebAppContext.java:1443)
        at 
org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1407)
        at 
org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:821)
        at 
org.eclipse.jetty.servlet.ServletContextHandler.doStart(ServletContextHandler.java:276)
        at 
org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:524)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:117)
        at 
org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
        at org.eclipse.jetty.server.Server.start(Server.java:407)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:110)
        at 
org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
        at org.eclipse.jetty.server.Server.doStart(Server.java:371)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.apache.geode.internal.cache.InternalHttpService.addWebApplication(InternalHttpService.java:207)
        at 
org.apache.geode.distributed.internal.InternalLocator.lambda$startClusterManagementService$1(InternalLocator.java:777)
        at java.util.Optional.ifPresent(Optional.java:159)
        at 
org.apache.geode.distributed.internal.InternalLocator.startClusterManagementService(InternalLocator.java:773)
        at 
org.apache.geode.distributed.internal.InternalLocator.startCache(InternalLocator.java:736)
        at 
org.apache.geode.distributed.internal.InternalLocator.startDistributedSystem(InternalLocator.java:715)
        at 
org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:378)
        at 
org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:328)
        at org.apache.geode.distributed.Locator.startLocator(Locator.java:252)
        at 
org.apache.geode.distributed.Locator.startLocatorAndDS(Locator.java:139)
        at 
org.apache.geode.test.dunit.internal.DUnitLauncher$1.call(DUnitLauncher.java:304)
        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.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123)
        at 
org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:92)
        at 
org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:45)
        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 sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
        at sun.rmi.transport.Transport$1.run(Transport.java:200)
        at sun.rmi.transport.Transport$1.run(Transport.java:197)
        at java.security.AccessController.doPrivileged(Native Method)
        at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
        at 
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:573)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:834)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:688)
        at java.security.AccessController.doPrivileged(Native Method)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:687)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
{noformat}
{noformat}
Caused by: java.lang.NoClassDefFoundError: 
org/apache/geode/internal/logging/LogService
        at 
org.apache.geode.management.internal.rest.controllers.ManagementControllerAdvice.<clinit>(ManagementControllerAdvice.java:54)
        at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
        at 
sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
        at 
sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
        at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
        at 
org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:142)
        at 
org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:89)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1151)
        ... 80 more
{noformat}
{noformat}
Caused by: java.lang.ClassNotFoundException: 
org.apache.geode.internal.logging.LogService
        at java.net.URLClassLoader.findClass(URLClassLoader.java:382)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
        at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:349)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
        at 
org.eclipse.jetty.webapp.WebAppClassLoader.loadClass(WebAppClassLoader.java:543)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
        ... 88 more
{noformat}

  was:
The background dunit locator is logging an error-level message with 
{{java.lang.ClassNotFoundException: 
org.apache.geode.internal.logging.LogService}} which does not seem to be found 
by the LogConsumer (aka the dunit grep-logs-for-suspect-strings). 

Note: LogService recently moved to a new package: 
{{org.apache.geode.logging.internal.log4j.api.LogService}}. The error-level 
message shows that the background dunit locator is trying to use the LogService 
in its old package.

I don't know if this is consistent or intermittent. I also don't know if this 
occurs in both CLI and IntelliJ runs of dunit tests. I'll try to confirm 
when/how this happens and add more details.

Using git grep for {{org.apache.geode.internal.logging.LogService}} finds no 
results, so I suspect this may involve the old geode versions that are pulled 
down locally for rolling upgrade and backwards compatibility tests. I'm 
concerned that those upgrade tests are creating invalid classpaths that mix 
versions of Geode.

{noformat}
[error 2019/11/01 14:48:50.877 PDT <RMI TCP Connection(1)-127.0.0.1> tid=0x13] 
Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean 
with name 'managementControllerAdvice' defined in file 
[/Users/klund/dev/gemfire/geode/geode-dunit/dunit/locator/GemFire_klund/services/http/0.0.0.0_7070_management_8c20b9f3/webapp/WEB-INF/classes/org/apache/geode/management/internal/rest/controllers/ManagementControllerAdvice.class]:
 Instantiation of bean failed; nested exception is 
java.lang.NoClassDefFoundError: org/apache/geode/internal/logging/LogService
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1159)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1103)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:511)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:481)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:312)
        at 
org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:308)
        at 
org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
        at 
org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:764)
        at 
org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:867)
        at 
org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542)
        at 
org.springframework.web.servlet.FrameworkServlet.configureAndRefreshWebApplicationContext(FrameworkServlet.java:668)
        at 
org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:634)
        at 
org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:682)
        at 
org.springframework.web.servlet.FrameworkServlet.initWebApplicationContext(FrameworkServlet.java:553)
        at 
org.springframework.web.servlet.FrameworkServlet.initServletBean(FrameworkServlet.java:494)
        at 
org.springframework.web.servlet.HttpServletBean.init(HttpServletBean.java:171)
        at javax.servlet.GenericServlet.init(GenericServlet.java:244)
        at 
org.eclipse.jetty.servlet.ServletHolder.initServlet(ServletHolder.java:599)
        at 
org.eclipse.jetty.servlet.ServletHolder.initialize(ServletHolder.java:425)
        at 
org.eclipse.jetty.servlet.ServletHandler.lambda$initialize$0(ServletHandler.java:751)
        at 
java.util.stream.SortedOps$SizedRefSortingSink.end(SortedOps.java:352)
        at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:482)
        at 
java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:471)
        at 
java.util.stream.StreamSpliterators$WrappingSpliterator.forEachRemaining(StreamSpliterators.java:312)
        at 
java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:743)
        at 
java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:742)
        at 
java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:580)
        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:744)
        at 
org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:361)
        at 
org.eclipse.jetty.webapp.WebAppContext.startWebapp(WebAppContext.java:1443)
        at 
org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1407)
        at 
org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:821)
        at 
org.eclipse.jetty.servlet.ServletContextHandler.doStart(ServletContextHandler.java:276)
        at 
org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:524)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:117)
        at 
org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
        at org.eclipse.jetty.server.Server.start(Server.java:407)
        at 
org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:110)
        at 
org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
        at org.eclipse.jetty.server.Server.doStart(Server.java:371)
        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
        at 
org.apache.geode.internal.cache.InternalHttpService.addWebApplication(InternalHttpService.java:207)
        at 
org.apache.geode.distributed.internal.InternalLocator.lambda$startClusterManagementService$1(InternalLocator.java:777)
        at java.util.Optional.ifPresent(Optional.java:159)
        at 
org.apache.geode.distributed.internal.InternalLocator.startClusterManagementService(InternalLocator.java:773)
        at 
org.apache.geode.distributed.internal.InternalLocator.startCache(InternalLocator.java:736)
        at 
org.apache.geode.distributed.internal.InternalLocator.startDistributedSystem(InternalLocator.java:715)
        at 
org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:378)
        at 
org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:328)
        at org.apache.geode.distributed.Locator.startLocator(Locator.java:252)
        at 
org.apache.geode.distributed.Locator.startLocatorAndDS(Locator.java:139)
        at 
org.apache.geode.test.dunit.internal.DUnitLauncher$1.call(DUnitLauncher.java:304)
        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.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123)
        at 
org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:92)
        at 
org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:45)
        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 sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
        at sun.rmi.transport.Transport$1.run(Transport.java:200)
        at sun.rmi.transport.Transport$1.run(Transport.java:197)
        at java.security.AccessController.doPrivileged(Native Method)
        at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
        at 
sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:573)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:834)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:688)
        at java.security.AccessController.doPrivileged(Native Method)
        at 
sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:687)
        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
        at java.lang.Thread.run(Thread.java:748)
{noformat}
{noformat}
Caused by: java.lang.NoClassDefFoundError: 
org/apache/geode/internal/logging/LogService
        at 
org.apache.geode.management.internal.rest.controllers.ManagementControllerAdvice.<clinit>(ManagementControllerAdvice.java:54)
        at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method)
        at 
sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
        at 
sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
        at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
        at 
org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:142)
        at 
org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:89)
        at 
org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1151)
        ... 80 more
{noformat}
{noformat}
Caused by: java.lang.ClassNotFoundException: 
org.apache.geode.internal.logging.LogService
        at java.net.URLClassLoader.findClass(URLClassLoader.java:382)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
        at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:349)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
        at 
org.eclipse.jetty.webapp.WebAppClassLoader.loadClass(WebAppClassLoader.java:543)
        at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
        ... 88 more
{noformat}


> dunit locator logs java.lang.ClassNotFoundException: 
> org.apache.geode.internal.logging.LogService
> -------------------------------------------------------------------------------------------------
>
>                 Key: GEODE-7403
>                 URL: https://issues.apache.org/jira/browse/GEODE-7403
>             Project: Geode
>          Issue Type: Bug
>          Components: logging, tests
>            Reporter: Kirk Lund
>            Priority: Major
>
> The background dunit locator is logging an error-level message with 
> {{java.lang.ClassNotFoundException: 
> org.apache.geode.internal.logging.LogService}} which does not seem to be 
> found by the LogConsumer (aka the dunit grep-logs-for-suspect-strings). 
> Note: LogService recently moved to a new package: 
> {{org.apache.geode.logging.internal.log4j.api.LogService}}. The error-level 
> message shows that the background dunit locator is trying to use the 
> LogService in its old package.
> I don't know if this is consistent or intermittent. I also don't know if this 
> occurs in both CLI and IntelliJ runs of dunit tests. I'll try to confirm 
> when/how this happens and add more details.
> Using git grep for {{org.apache.geode.internal.logging.LogService}} finds no 
> results, so I suspect this may involve the old geode versions that are pulled 
> down locally for rolling upgrade and backwards compatibility tests. I'm 
> concerned that those upgrade tests are creating invalid classpaths that mix 
> versions of Geode.
> The following is logged by the dunit locator as one long stack. I've divided 
> it into three sections with markdown to facilitate seeing the two Causes 
> without scrolling.
> {noformat}
> [error 2019/11/01 14:48:50.877 PDT <RMI TCP Connection(1)-127.0.0.1> 
> tid=0x13] Context initialization failed
> org.springframework.beans.factory.BeanCreationException: Error creating bean 
> with name 'managementControllerAdvice' defined in file 
> [/Users/klund/dev/gemfire/geode/geode-dunit/dunit/locator/GemFire_klund/services/http/0.0.0.0_7070_management_8c20b9f3/webapp/WEB-INF/classes/org/apache/geode/management/internal/rest/controllers/ManagementControllerAdvice.class]:
>  Instantiation of bean failed; nested exception is 
> java.lang.NoClassDefFoundError: org/apache/geode/internal/logging/LogService
>         at 
> org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1159)
>         at 
> org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBeanInstance(AbstractAutowireCapableBeanFactory.java:1103)
>         at 
> org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:511)
>         at 
> org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:481)
>         at 
> org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:312)
>         at 
> org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:230)
>         at 
> org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:308)
>         at 
> org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:197)
>         at 
> org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:764)
>         at 
> org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:867)
>         at 
> org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:542)
>         at 
> org.springframework.web.servlet.FrameworkServlet.configureAndRefreshWebApplicationContext(FrameworkServlet.java:668)
>         at 
> org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:634)
>         at 
> org.springframework.web.servlet.FrameworkServlet.createWebApplicationContext(FrameworkServlet.java:682)
>         at 
> org.springframework.web.servlet.FrameworkServlet.initWebApplicationContext(FrameworkServlet.java:553)
>         at 
> org.springframework.web.servlet.FrameworkServlet.initServletBean(FrameworkServlet.java:494)
>         at 
> org.springframework.web.servlet.HttpServletBean.init(HttpServletBean.java:171)
>         at javax.servlet.GenericServlet.init(GenericServlet.java:244)
>         at 
> org.eclipse.jetty.servlet.ServletHolder.initServlet(ServletHolder.java:599)
>         at 
> org.eclipse.jetty.servlet.ServletHolder.initialize(ServletHolder.java:425)
>         at 
> org.eclipse.jetty.servlet.ServletHandler.lambda$initialize$0(ServletHandler.java:751)
>         at 
> java.util.stream.SortedOps$SizedRefSortingSink.end(SortedOps.java:352)
>         at 
> java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:482)
>         at 
> java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:471)
>         at 
> java.util.stream.StreamSpliterators$WrappingSpliterator.forEachRemaining(StreamSpliterators.java:312)
>         at 
> java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:743)
>         at 
> java.util.stream.Streams$ConcatSpliterator.forEachRemaining(Streams.java:742)
>         at 
> java.util.stream.ReferencePipeline$Head.forEach(ReferencePipeline.java:580)
>         at 
> org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:744)
>         at 
> org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:361)
>         at 
> org.eclipse.jetty.webapp.WebAppContext.startWebapp(WebAppContext.java:1443)
>         at 
> org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1407)
>         at 
> org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:821)
>         at 
> org.eclipse.jetty.servlet.ServletContextHandler.doStart(ServletContextHandler.java:276)
>         at 
> org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:524)
>         at 
> org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
>         at 
> org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
>         at 
> org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:117)
>         at 
> org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
>         at 
> org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
>         at 
> org.eclipse.jetty.util.component.ContainerLifeCycle.start(ContainerLifeCycle.java:169)
>         at org.eclipse.jetty.server.Server.start(Server.java:407)
>         at 
> org.eclipse.jetty.util.component.ContainerLifeCycle.doStart(ContainerLifeCycle.java:110)
>         at 
> org.eclipse.jetty.server.handler.AbstractHandler.doStart(AbstractHandler.java:106)
>         at org.eclipse.jetty.server.Server.doStart(Server.java:371)
>         at 
> org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:72)
>         at 
> org.apache.geode.internal.cache.InternalHttpService.addWebApplication(InternalHttpService.java:207)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.lambda$startClusterManagementService$1(InternalLocator.java:777)
>         at java.util.Optional.ifPresent(Optional.java:159)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.startClusterManagementService(InternalLocator.java:773)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.startCache(InternalLocator.java:736)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.startDistributedSystem(InternalLocator.java:715)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:378)
>         at 
> org.apache.geode.distributed.internal.InternalLocator.startLocator(InternalLocator.java:328)
>         at org.apache.geode.distributed.Locator.startLocator(Locator.java:252)
>         at 
> org.apache.geode.distributed.Locator.startLocatorAndDS(Locator.java:139)
>         at 
> org.apache.geode.test.dunit.internal.DUnitLauncher$1.call(DUnitLauncher.java:304)
>         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.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:123)
>         at 
> org.apache.geode.test.dunit.internal.MethodInvoker.executeObject(MethodInvoker.java:92)
>         at 
> org.apache.geode.test.dunit.internal.RemoteDUnitVM.executeMethodOnObject(RemoteDUnitVM.java:45)
>         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 sun.rmi.server.UnicastServerRef.dispatch(UnicastServerRef.java:357)
>         at sun.rmi.transport.Transport$1.run(Transport.java:200)
>         at sun.rmi.transport.Transport$1.run(Transport.java:197)
>         at java.security.AccessController.doPrivileged(Native Method)
>         at sun.rmi.transport.Transport.serviceCall(Transport.java:196)
>         at 
> sun.rmi.transport.tcp.TCPTransport.handleMessages(TCPTransport.java:573)
>         at 
> sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run0(TCPTransport.java:834)
>         at 
> sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.lambda$run$0(TCPTransport.java:688)
>         at java.security.AccessController.doPrivileged(Native Method)
>         at 
> sun.rmi.transport.tcp.TCPTransport$ConnectionHandler.run(TCPTransport.java:687)
>         at 
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
>         at 
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
>         at java.lang.Thread.run(Thread.java:748)
> {noformat}
> {noformat}
> Caused by: java.lang.NoClassDefFoundError: 
> org/apache/geode/internal/logging/LogService
>         at 
> org.apache.geode.management.internal.rest.controllers.ManagementControllerAdvice.<clinit>(ManagementControllerAdvice.java:54)
>         at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native 
> Method)
>         at 
> sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62)
>         at 
> sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45)
>         at java.lang.reflect.Constructor.newInstance(Constructor.java:423)
>         at 
> org.springframework.beans.BeanUtils.instantiateClass(BeanUtils.java:142)
>         at 
> org.springframework.beans.factory.support.SimpleInstantiationStrategy.instantiate(SimpleInstantiationStrategy.java:89)
>         at 
> org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.instantiateBean(AbstractAutowireCapableBeanFactory.java:1151)
>         ... 80 more
> {noformat}
> {noformat}
> Caused by: java.lang.ClassNotFoundException: 
> org.apache.geode.internal.logging.LogService
>         at java.net.URLClassLoader.findClass(URLClassLoader.java:382)
>         at java.lang.ClassLoader.loadClass(ClassLoader.java:424)
>         at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:349)
>         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
>         at 
> org.eclipse.jetty.webapp.WebAppClassLoader.loadClass(WebAppClassLoader.java:543)
>         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
>         ... 88 more
> {noformat}



--
This message was sent by Atlassian Jira
(v8.3.4#803005)

Reply via email to