Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/23745/ Java: 64bit/jdk-12-ea+shipilev-fastdebug -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed. FAILED: org.apache.solr.TestDistributedGrouping.test Error Message: Error from server at http://127.0.0.1:37311/collection1: Error from server at null: java.lang.NullPointerException at org.apache.solr.handler.component.ResponseBuilder.setResult(ResponseBuilder.java:466) at org.apache.solr.handler.component.QueryComponent.doProcessGroupedDistributedSearchSecondPhase(QueryComponent.java:1369) at org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:362) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:298) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2565) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:703) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.Server.handle(Server.java:502) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) at org.eclipse.jetty.server.HttpChannel.run(HttpChannel.java:305) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) at java.base/java.lang.Thread.run(Thread.java:835) Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37311/collection1: Error from server at null: java.lang.NullPointerException at org.apache.solr.handler.component.ResponseBuilder.setResult(ResponseBuilder.java:466) at org.apache.solr.handler.component.QueryComponent.doProcessGroupedDistributedSearchSecondPhase(QueryComponent.java:1369) at org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:362) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:298) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2565) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:703) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.Server.handle(Server.java:502) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) at org.eclipse.jetty.server.HttpChannel.run(HttpChannel.java:305) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) at java.base/java.lang.Thread.run(Thread.java:835) at __randomizedtesting.SeedInfo.seed([D43E17F819B0EA0C:5C6A2822B74C87F4]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:649) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:987) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1002) at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:626) at org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:321) at org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:309) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1108) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:835) FAILED: org.apache.solr.TestDistributedGrouping.test Error Message: Error from server at http://127.0.0.1:44913/collection1: Error from server at null: java.lang.NullPointerException at org.apache.solr.handler.component.ResponseBuilder.setResult(ResponseBuilder.java:466) at org.apache.solr.handler.component.QueryComponent.doProcessGroupedDistributedSearchSecondPhase(QueryComponent.java:1369) at org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:362) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:298) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2565) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:703) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.Server.handle(Server.java:502) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) at org.eclipse.jetty.server.HttpChannel.run(HttpChannel.java:305) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) at java.base/java.lang.Thread.run(Thread.java:835) Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:44913/collection1: Error from server at null: java.lang.NullPointerException at org.apache.solr.handler.component.ResponseBuilder.setResult(ResponseBuilder.java:466) at org.apache.solr.handler.component.QueryComponent.doProcessGroupedDistributedSearchSecondPhase(QueryComponent.java:1369) at org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:362) at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:298) at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) at org.apache.solr.core.SolrCore.execute(SolrCore.java:2565) at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711) at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394) at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:703) at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) at org.eclipse.jetty.server.Server.handle(Server.java:502) at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) at org.eclipse.jetty.server.HttpChannel.run(HttpChannel.java:305) at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) at java.base/java.lang.Thread.run(Thread.java:835) at __randomizedtesting.SeedInfo.seed([D43E17F819B0EA0C:5C6A2822B74C87F4]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:649) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:987) at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1002) at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:626) at org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:321) at org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:309) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:567) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1108) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:835) Build Log: [...truncated 14082 lines...] [junit4] Suite: org.apache.solr.TestDistributedGrouping [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/init-core-data-001 [junit4] 2> 1881263 WARN (SUITE-TestDistributedGrouping-seed#[D43E17F819B0EA0C]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2 [junit4] 2> 1881263 INFO (SUITE-TestDistributedGrouping-seed#[D43E17F819B0EA0C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 1881264 INFO (SUITE-TestDistributedGrouping-seed#[D43E17F819B0EA0C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 1881264 INFO (SUITE-TestDistributedGrouping-seed#[D43E17F819B0EA0C]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 1881265 INFO (SUITE-TestDistributedGrouping-seed#[D43E17F819B0EA0C]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: / [junit4] 2> 1881446 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/control/cores/collection1 [junit4] 2> 1881447 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1881447 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1881447 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1881447 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 1881448 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1881448 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1881448 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 1881449 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@749e66d1{/,null,AVAILABLE} [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@259d1ba7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:35489} [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.Server Started @1881538ms [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=35489, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/control/cores} [junit4] 2> 1881486 ERROR (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1881486 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-05T01:40:29.964956Z [junit4] 2> 1881487 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/control/solr.xml [junit4] 2> 1881492 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1881492 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1881493 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1881657 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1881662 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@26419ddf[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1881668 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@4b6ee4b4[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1881697 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1881697 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1881727 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1881760 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1881760 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1881763 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/control/cores [junit4] 2> 1881763 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1881764 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1881825 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 1881856 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1882045 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1882062 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1882062 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1882062 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 1882065 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@33f86f54 [junit4] 2> 1882241 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1882241 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1882244 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1882244 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1882246 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5783590314729612] [junit4] 2> 1882247 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5cf3d6b8[collection1] main] [junit4] 2> 1882248 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1882269 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1882407 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1882407 INFO (coreLoadExecutor-5428-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1627127840385269760 [junit4] 2> 1882409 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1882409 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1882409 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1882409 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1882410 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1882410 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1882410 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1882410 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1882410 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1882412 INFO (searcherExecutor-5429-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5cf3d6b8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1882541 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/shard0/cores/collection1 [junit4] 2> 1882541 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 1882542 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0) [junit4] 2> 1882542 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 1882542 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 12-testing+0-builds.shipilev.net-openjdk-jdk12-b109-20190215-jdk-1229 [junit4] 2> 1882542 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3794d9ff{/,null,AVAILABLE} [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@43e3844f{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:44913} [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.s.Server Started @1882596ms [junit4] 2> 1882543 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, hostPort=44913, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/shard0/cores} [junit4] 2> 1882544 ERROR (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 9.0.0 [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-05T01:40:31.022421Z [junit4] 2> 1882544 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/shard0/solr.xml [junit4] 2> 1882549 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored [junit4] 2> 1882549 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored [junit4] 2> 1882550 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1, but no JMX reporters were configured - adding default JMX reporter. [junit4] 2> 1882654 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false] [junit4] 2> 1882656 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@42f7d7f8[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1882660 WARN (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@37054354[provider=null,keyStore=null,trustStore=null] [junit4] 2> 1882682 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores [junit4] 2> 1882682 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1882723 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1882748 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1882748 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1882751 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/shard0/cores [junit4] 2> 1882751 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 1882752 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 1882788 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 1882874 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 1882972 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 1882982 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1, trusted=true [junit4] 2> 1882982 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@43437a1 [junit4] 2> 1882983 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 1882985 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@28a0fbfd [junit4] 2> 1883048 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 1883048 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 1883051 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 1883051 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 1883052 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=23, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5783590314729612] [junit4] 2> 1883052 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@49409797[collection1] main] [junit4] 2> 1883053 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 1883189 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1883276 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 1883276 INFO (coreLoadExecutor-5442-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1627127841296482304 [junit4] 2> 1883277 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 1883278 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 1883279 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 1883279 INFO (TEST-TestDistributedGrouping.test-seed#[D43E17F819B0EA0C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 1883280 INFO (searcherExecutor-5443-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@49409797[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1883283 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1627127841301725184)} 0 2 [junit4] 2> 1883288 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{deleteByQuery=*:* (-1627127841306968064)} 0 2 [junit4] 2> 1883289 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1627127841310113792,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1883289 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 1883290 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1883290 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1 [junit4] 2> 1883290 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1627127841311162368,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1883290 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit. [junit4] 2> 1883291 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 1883291 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 0 [junit4] 2> 1883328 INFO (qtp913751971-22731) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=36 [junit4] 2> 1883336 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=http://127.0.0.1:44913/collection1|[ff01::083]:33332/|[ff01::213]:33332/&rows=100&version=2&q=*:*&NOW=1551750031806&isShard=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=1 [junit4] 2> 1883337 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=http://127.0.0.1:44913/collection1|[ff01::083]:33332/|[ff01::213]:33332/&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=8 [junit4] 2> 1883338 INFO (qtp913751971-22732) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&distrib=false&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=0 [junit4] 2> 1883344 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&hl=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:44913/collection1&rows=100&version=2&q=*:*&NOW=1551750031816&isShard=true&hl.fl=a_t&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883345 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:44913/collection1&hl=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&hl.fl=a_t&rows=100&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=6 [junit4] 2> 1883347 INFO (qtp913751971-22733) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true} hits=0 status=0 QTime=0 [junit4] 2> 1883349 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=http://127.0.0.1:44913/collection1|[ff01::213]:33332/&rows=100&version=2&q=*:*&NOW=1551750031825&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883351 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&sort=a_i1+asc,+id+asc&shard.url=http://127.0.0.1:44913/collection1|[ff01::213]:33332/&rows=100&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&NOW=1551750031825&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883353 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=http://127.0.0.1:44913/collection1|[ff01::213]:33332/&facet.field=a_t&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&facet=true&wt=javabin&version=2&group.field=a_i1&group=true} status=0 QTime=5 [junit4] 2> 1883355 INFO (qtp913751971-22731) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&distrib=false&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1} hits=0 status=0 QTime=1 [junit4] 2> 1883396 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:44913/collection1&rows=100&version=2&q=*:*&stats=false&NOW=1551750031872&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=0 [junit4] 2> 1883397 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=516&start=0&sort=a_i1+asc,+id+asc&shard.url=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:44913/collection1&rows=100&version=2&group.distributed.second=true&q=*:*&stats=true&NOW=1551750031872&isShard=true&wt=javabin&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=0 [junit4] 2> 1883480 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={q=*:*&shards=[ff01::213]:33332/|[ff01::114]:33332/|[ff01::083]:33332/|http://127.0.0.1:44913/collection1&stats=true&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&wt=javabin&version=2&group.field=a_i1&group=true&stats.field=a_i1} status=0 QTime=86 [junit4] 2> 1883489 INFO (qtp913751971-22732) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=subject&distrib=false&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&wt=javabin&group.field=a_i1&group=true} hits=0 status=0 QTime=0 [junit4] 2> 1883494 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=subject&group.distributed.first=true&distrib=false&qt=spellCheckCompRH&fl=id&group.limit=-1&shards.purpose=2048&start=0&sort=a_i1+asc,+id+asc&shard.url=http://127.0.0.1:44913/collection1&rows=100&version=2&spellcheck.build=true&q=kings&spellcheck=true&NOW=1551750031971&isShard=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883495 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={df=subject&qt=spellCheckCompRH&fl=id,a_i1&group.limit=-1&sort=a_i1+asc,+id+asc&rows=100&version=2&spellcheck.build=true&q=kings&shards=http://127.0.0.1:44913/collection1&spellcheck=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=2 [junit4] 2> 1883694 INFO (qtp913751971-22733) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&distrib=false&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true} hits=0 status=0 QTime=198 [junit4] 2> 1883696 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&df=text&group.distributed.first=true&distrib=false&fl=id&group.limit=-1&shards.purpose=2048&start=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:44913/collection1&rows=100&version=2&q=*:*&group.truncate=true&NOW=1551750032173&isShard=true&facet=false&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883698 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&df=text&distrib=false&fl=id&group.limit=-1&shards.purpose=20&start=0&f.a_t.facet.mincount=0&fq=a_s:a&sort=a_i1+asc,+id+asc&shard.url=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:44913/collection1&rows=100&version=2&group.distributed.second=true&q=*:*&f.a_t.facet.limit=160&group.truncate=true&NOW=1551750032173&isShard=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=0 [junit4] 2> 1883699 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.c.S.Request [collection1] webapp= path=/select params={facet.field=a_t&fl=id,a_i1&group.limit=-1&fq=a_s:a&sort=a_i1+asc,+id+asc&rows=100&version=2&q=*:*&shards=[ff01::114]:33332/|[ff01::213]:33332/|http://127.0.0.1:44913/collection1&group.truncate=true&facet=true&wt=javabin&group.field=a_i1&group=true} status=0 QTime=4 [junit4] 2> 1883705 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1627127841742127104)]} 0 4 [junit4] 2> 1883708 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[1 (1627127841747369984)]} 0 2 [junit4] 2> 1883710 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1627127841750515712)]} 0 0 [junit4] 2> 1883711 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[2 (1627127841751564288)]} 0 0 [junit4] 2> 1883712 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1627127841752612864)]} 0 0 [junit4] 2> 1883713 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[3 (1627127841753661440)]} 0 0 [junit4] 2> 1883714 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1627127841754710016)]} 0 0 [junit4] 2> 1883715 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[4 (1627127841755758592)]} 0 0 [junit4] 2> 1883716 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1627127841756807168)]} 0 0 [junit4] 2> 1883717 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[5 (1627127841757855744)]} 0 0 [junit4] 2> 1883721 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1627127841763098624)]} 0 0 [junit4] 2> 1883722 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[6 (1627127841764147200)]} 0 0 [junit4] 2> 1883723 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1627127841765195776)]} 0 0 [junit4] 2> 1883724 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[7 (1627127841766244352)]} 0 0 [junit4] 2> 1883725 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1627127841767292928)]} 0 0 [junit4] 2> 1883726 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[8 (1627127841768341504)]} 0 0 [junit4] 2> 1883727 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1627127841769390080)]} 0 0 [junit4] 2> 1883728 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[9 (1627127841770438656)]} 0 0 [junit4] 2> 1883729 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[10 (1627127841771487232)]} 0 0 [junit4] 2> 1883730 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[10 (1627127841771487232)]} 0 0 [junit4] 2> 1883731 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[11 (1627127841772535808)]} 0 0 [junit4] 2> 1883731 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[11 (1627127841773584384)]} 0 0 [junit4] 2> 1883732 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[12 (1627127841774632960)]} 0 0 [junit4] 2> 1883733 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[12 (1627127841775681536)]} 0 0 [junit4] 2> 1883734 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[14 (1627127841776730112)]} 0 0 [junit4] 2> 1883735 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[14 (1627127841776730112)]} 0 0 [junit4] 2> 1883736 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[15 (1627127841777778688)]} 0 0 [junit4] 2> 1883736 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[15 (1627127841778827264)]} 0 0 [junit4] 2> 1883737 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[16 (1627127841779875840)]} 0 0 [junit4] 2> 1883738 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[16 (1627127841779875840)]} 0 0 [junit4] 2> 1883739 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[17 (1627127841780924416)]} 0 0 [junit4] 2> 1883740 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[17 (1627127841781972992)]} 0 0 [junit4] 2> 1883741 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[18 (1627127841784070144)]} 0 0 [junit4] 2> 1883742 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[18 (1627127841785118720)]} 0 0 [junit4] 2> 1883743 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[19 (1627127841786167296)]} 0 0 [junit4] 2> 1883744 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[19 (1627127841787215872)]} 0 0 [junit4] 2> 1883745 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[20 (1627127841788264448)]} 0 0 [junit4] 2> 1883746 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[20 (1627127841788264448)]} 0 0 [junit4] 2> 1883747 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[21 (1627127841789313024)]} 0 0 [junit4] 2> 1883747 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[21 (1627127841790361600)]} 0 0 [junit4] 2> 1883749 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[22 (1627127841791410176)]} 0 0 [junit4] 2> 1883749 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[22 (1627127841792458752)]} 0 0 [junit4] 2> 1883751 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[23 (1627127841793507328)]} 0 0 [junit4] 2> 1883751 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[23 (1627127841794555904)]} 0 0 [junit4] 2> 1883752 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[100 (1627127841795604480)]} 0 0 [junit4] 2> 1883753 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[100 (1627127841796653056)]} 0 0 [junit4] 2> 1883753 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[101 (1627127841796653056)]} 0 0 [junit4] 2> 1883754 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[101 (1627127841797701632)]} 0 0 [junit4] 2> 1883755 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[102 (1627127841797701632)]} 0 0 [junit4] 2> 1883755 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[102 (1627127841798750208)]} 0 0 [junit4] 2> 1883756 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[103 (1627127841799798784)]} 0 0 [junit4] 2> 1883757 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[103 (1627127841800847360)]} 0 0 [junit4] 2> 1883758 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[104 (1627127841800847360)]} 0 0 [junit4] 2> 1883758 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[104 (1627127841801895936)]} 0 0 [junit4] 2> 1883760 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[105 (1627127841802944512)]} 0 0 [junit4] 2> 1883760 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[105 (1627127841803993088)]} 0 0 [junit4] 2> 1883761 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[106 (1627127841805041664)]} 0 0 [junit4] 2> 1883762 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[106 (1627127841805041664)]} 0 0 [junit4] 2> 1883763 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[107 (1627127841806090240)]} 0 0 [junit4] 2> 1883763 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[107 (1627127841807138816)]} 0 0 [junit4] 2> 1883764 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[108 (1627127841807138816)]} 0 0 [junit4] 2> 1883765 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[108 (1627127841809235968)]} 0 0 [junit4] 2> 1883768 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[109 (1627127841811333120)]} 0 0 [junit4] 2> 1883769 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[109 (1627127841812381696)]} 0 0 [junit4] 2> 1883769 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[110 (1627127841813430272)]} 0 0 [junit4] 2> 1883770 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[110 (1627127841814478848)]} 0 0 [junit4] 2> 1883776 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[111 (1627127841815527424)]} 0 5 [junit4] 2> 1883778 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[111 (1627127841821818880)]} 0 0 [junit4] 2> 1883778 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[112 (1627127841822867456)]} 0 0 [junit4] 2> 1883779 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[112 (1627127841823916032)]} 0 0 [junit4] 2> 1883780 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[113 (1627127841823916032)]} 0 0 [junit4] 2> 1883780 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[113 (1627127841824964608)]} 0 0 [junit4] 2> 1883781 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[114 (1627127841826013184)]} 0 0 [junit4] 2> 1883782 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[114 (1627127841826013184)]} 0 0 [junit4] 2> 1883782 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[115 (1627127841827061760)]} 0 0 [junit4] 2> 1883783 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[115 (1627127841828110336)]} 0 0 [junit4] 2> 1883784 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[116 (1627127841829158912)]} 0 0 [junit4] 2> 1883785 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[116 (1627127841829158912)]} 0 0 [junit4] 2> 1883785 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[117 (1627127841830207488)]} 0 0 [junit4] 2> 1883786 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[117 (1627127841831256064)]} 0 0 [junit4] 2> 1883787 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[118 (1627127841832304640)]} 0 0 [junit4] 2> 1883787 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[118 (1627127841832304640)]} 0 0 [junit4] 2> 1883788 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[119 (1627127841833353216)]} 0 0 [junit4] 2> 1883789 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[119 (1627127841833353216)]} 0 0 [junit4] 2> 1883789 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[120 (1627127841834401792)]} 0 0 [junit4] 2> 1883790 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[120 (1627127841835450368)]} 0 0 [junit4] 2> 1883791 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[121 (1627127841835450368)]} 0 0 [junit4] 2> 1883791 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[121 (1627127841836498944)]} 0 0 [junit4] 2> 1883792 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[122 (1627127841837547520)]} 0 0 [junit4] 2> 1883793 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[122 (1627127841837547520)]} 0 0 [junit4] 2> 1883793 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[123 (1627127841838596096)]} 0 0 [junit4] 2> 1883794 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[123 (1627127841839644672)]} 0 0 [junit4] 2> 1883795 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[124 (1627127841839644672)]} 0 0 [junit4] 2> 1883795 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[124 (1627127841840693248)]} 0 0 [junit4] 2> 1883796 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[125 (1627127841841741824)]} 0 0 [junit4] 2> 1883796 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[125 (1627127841841741824)]} 0 0 [junit4] 2> 1883797 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[126 (1627127841842790400)]} 0 0 [junit4] 2> 1883798 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[126 (1627127841843838976)]} 0 0 [junit4] 2> 1883798 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[127 (1627127841843838976)]} 0 0 [junit4] 2> 1883799 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[127 (1627127841844887552)]} 0 0 [junit4] 2> 1883800 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[128 (1627127841844887552)]} 0 0 [junit4] 2> 1883800 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[128 (1627127841845936128)]} 0 0 [junit4] 2> 1883801 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[129 (1627127841846984704)]} 0 0 [junit4] 2> 1883802 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[129 (1627127841848033280)]} 0 0 [junit4] 2> 1883804 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[130 (1627127841849081856)]} 0 0 [junit4] 2> 1883805 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[130 (1627127841850130432)]} 0 0 [junit4] 2> 1883805 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[131 (1627127841851179008)]} 0 0 [junit4] 2> 1883806 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[131 (1627127841852227584)]} 0 0 [junit4] 2> 1883807 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[132 (1627127841853276160)]} 0 0 [junit4] 2> 1883808 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[132 (1627127841853276160)]} 0 0 [junit4] 2> 1883808 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[133 (1627127841854324736)]} 0 0 [junit4] 2> 1883809 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[133 (1627127841855373312)]} 0 0 [junit4] 2> 1883817 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[134 (1627127841863761920)]} 0 8 [junit4] 2> 1883822 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[134 (1627127841869004800)]} 0 0 [junit4] 2> 1883823 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[135 (1627127841870053376)]} 0 0 [junit4] 2> 1883824 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[135 (1627127841870053376)]} 0 0 [junit4] 2> 1883824 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[136 (1627127841871101952)]} 0 0 [junit4] 2> 1883825 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[136 (1627127841872150528)]} 0 0 [junit4] 2> 1883829 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[137 (1627127841876344832)]} 0 0 [junit4] 2> 1883830 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[137 (1627127841877393408)]} 0 0 [junit4] 2> 1883831 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[138 (1627127841877393408)]} 0 0 [junit4] 2> 1883833 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[138 (1627127841880539136)]} 0 0 [junit4] 2> 1883834 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[139 (1627127841881587712)]} 0 0 [junit4] 2> 1883835 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[139 (1627127841882636288)]} 0 0 [junit4] 2> 1883836 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[140 (1627127841882636288)]} 0 0 [junit4] 2> 1883836 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[140 (1627127841883684864)]} 0 0 [junit4] 2> 1883837 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[141 (1627127841884733440)]} 0 0 [junit4] 2> 1883838 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[141 (1627127841884733440)]} 0 0 [junit4] 2> 1883838 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[142 (1627127841885782016)]} 0 0 [junit4] 2> 1883839 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[142 (1627127841886830592)]} 0 0 [junit4] 2> 1883840 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[143 (1627127841887879168)]} 0 0 [junit4] 2> 1883841 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[143 (1627127841888927744)]} 0 0 [junit4] 2> 1883842 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[144 (1627127841889976320)]} 0 0 [junit4] 2> 1883842 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[144 (1627127841889976320)]} 0 0 [junit4] 2> 1883843 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[145 (1627127841891024896)]} 0 0 [junit4] 2> 1883844 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[145 (1627127841892073472)]} 0 0 [junit4] 2> 1883845 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[146 (1627127841892073472)]} 0 0 [junit4] 2> 1883845 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[146 (1627127841893122048)]} 0 0 [junit4] 2> 1883846 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[147 (1627127841894170624)]} 0 0 [junit4] 2> 1883847 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[147 (1627127841894170624)]} 0 0 [junit4] 2> 1883848 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[148 (1627127841896267776)]} 0 0 [junit4] 2> 1883849 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[148 (1627127841897316352)]} 0 0 [junit4] 2> 1883850 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[149 (1627127841897316352)]} 0 0 [junit4] 2> 1883850 INFO (qtp1239469148-22753) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[149 (1627127841898364928)]} 0 0 [junit4] 2> 1883851 INFO (qtp913751971-22731) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[500 (1627127841899413504)]} 0 0 [junit4] 2> 1883851 INFO (qtp1239469148-22752) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[500 (1627127841899413504)]} 0 0 [junit4] 2> 1883852 INFO (qtp913751971-22732) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[501 (1627127841900462080)]} 0 0 [junit4] 2> 1883853 INFO (qtp1239469148-22754) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp= path=/update params={wt=javabin&version=2}{add=[501 (1627127841901510656)]} 0 0 [junit4] 2> 1883854 INFO (qtp913751971-22733) [ x:collection1] o.a.s.u.p.LogUpdatePr [...truncated too long message...] > 48586 INFO (closeThreadPool-13-thread-2) [ ] o.a.s.m.SolrMetricManager > Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 48587 INFO (closeThreadPool-13-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4d85005: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@349d123f [junit4] 2> 48588 INFO (closeThreadPool-13-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6ae49680: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@349d123f [junit4] 2> 48751 INFO (closeThreadPool-13-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@32c4d119{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 48794 INFO (closeThreadPool-13-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@28235491{/,null,UNAVAILABLE} [junit4] 2> 48809 INFO (closeThreadPool-13-thread-2) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 48828 INFO (closeThreadPool-13-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4cd98b58{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 48834 INFO (closeThreadPool-13-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@21fadded{/,null,UNAVAILABLE} [junit4] 2> 48834 INFO (closeThreadPool-13-thread-4) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestDistributedGrouping -Dtests.method=test -Dtests.seed=D43E17F819B0EA0C -Dtests.multiplier=3 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=teo-UG -Dtests.timezone=Asia/Kashgar -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 41.0s J0 | TestDistributedGrouping.test <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37311/collection1: Error from server at null: java.lang.NullPointerException [junit4] > at org.apache.solr.handler.component.ResponseBuilder.setResult(ResponseBuilder.java:466) [junit4] > at org.apache.solr.handler.component.QueryComponent.doProcessGroupedDistributedSearchSecondPhase(QueryComponent.java:1369) [junit4] > at org.apache.solr.handler.component.QueryComponent.process(QueryComponent.java:362) [junit4] > at org.apache.solr.handler.component.SearchHandler.handleRequestBody(SearchHandler.java:298) [junit4] > at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:199) [junit4] > at org.apache.solr.core.SolrCore.execute(SolrCore.java:2565) [junit4] > at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:711) [junit4] > at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:516) [junit4] > at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:394) [junit4] > at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:340) [junit4] > at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) [junit4] > at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:165) [junit4] > at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1610) [junit4] > at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:540) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] > at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1588) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:255) [junit4] > at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1345) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:203) [junit4] > at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:480) [junit4] > at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1557) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:201) [junit4] > at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1247) [junit4] > at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:144) [junit4] > at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:703) [junit4] > at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:132) [junit4] > at org.eclipse.jetty.server.Server.handle(Server.java:502) [junit4] > at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:364) [junit4] > at org.eclipse.jetty.server.HttpChannel.run(HttpChannel.java:305) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:765) [junit4] > at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:683) [junit4] > at java.base/java.lang.Thread.run(Thread.java:835) [junit4] > at __randomizedtesting.SeedInfo.seed([D43E17F819B0EA0C:5C6A2822B74C87F4]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:649) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:987) [junit4] > at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:1002) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.queryServer(BaseDistributedSearchTestCase.java:626) [junit4] > at org.apache.solr.TestDistributedGrouping.simpleQuery(TestDistributedGrouping.java:321) [junit4] > at org.apache.solr.TestDistributedGrouping.test(TestDistributedGrouping.java:309) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:567) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsRepeatStatement.callStatement(BaseDistributedSearchTestCase.java:1108) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054) [junit4] > at java.base/java.lang.Thread.run(Thread.java:835) [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.TestDistributedGrouping_D43E17F819B0EA0C-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@74789cf4), locale=teo-UG, timezone=Asia/Kashgar [junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 12-testing (64-bit)/cpus=8,threads=3,free=44130384,total=145752064 [junit4] 2> NOTE: All tests run in this JVM: [TestDistributedGrouping] [junit4] Completed [2/5 (2!)] on J0 in 46.64s, 1 test, 1 error <<< FAILURES! [...truncated 25 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1572: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:1099: There were test failures: 5 suites, 5 tests, 2 errors [seed: D43E17F819B0EA0C] Total time: 1 minute 43 seconds [repro] Setting last failure code to 256 [repro] Failures: [repro] 2/5 failed: org.apache.solr.TestDistributedGrouping [repro] Exiting with code 256 + mv lucene/build lucene/build.repro + mv solr/build solr/build.repro + mv lucene/build.orig lucene/build + mv solr/build.orig solr/build Archiving artifacts Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 No credentials specified Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=7bfe7b265a4091048707e782657f622e937b6e70, workspace=/home/jenkins/workspace/Lucene-Solr-master-Linux [WARNINGS] Computing warning deltas based on reference build #23744 Recording test results Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2 Setting ANT_1_8_2_HOME=/home/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org